builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-049 starttime: 1502879663.19 results: success (0) revision: 6ebc251bd288c268b020815025b05854ccde5c08 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-16 03:34:23.188341) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-16 03:34:23.188787) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-16 03:34:23.189087) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-16 03:34:23.201797) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:34:23.202092) ========= 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=db7e7c15f3ca076d53731445000001ba-1502879662.959386-1115570645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-16 03:34:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.0M=0s 2017-08-16 03:34:23 (50.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.075543 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:34:23.295891) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:34:23.296218) ========= 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=db7e7c15f3ca076d53731445000001ba-1502879662.959386-1115570645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017384 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:34:23.345408) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:34:23.348810) ========= 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=db7e7c15f3ca076d53731445000001ba-1502879662.959386-1115570645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-16 03:34:24,027 truncating revision to first 12 chars 2017-08-16 03:34:24,027 Setting DEBUG logging. 2017-08-16 03:34:24,027 attempt 1/10 2017-08-16 03:34:24,027 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:34:24,458 unpacking tar archive at: mozilla-central-6ebc251bd288/testing/mozharness/ program finished with exit code 0 elapsedTime=0.733135 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:34:24.096395) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-16 03:34:24.099741) ========= script_repo_revision: 6ebc251bd288c268b020815025b05854ccde5c08 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-16 03:34:24.100126) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-16 03:34:24.100391) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-16 03:34:24.111920) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-16 03:34:24.112195) ========= /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=db7e7c15f3ca076d53731445000001ba-1502879662.959386-1115570645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:34:24 INFO - MultiFileLogger online at 20170816 03:34:24 in /builds/slave/test 03:34:24 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:34:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:34:24 INFO - {'append_to_log': False, 03:34:24 INFO - 'base_work_dir': '/builds/slave/test', 03:34:24 INFO - 'blob_upload_branch': 'Firefox', 03:34:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:34:24 INFO - 'branch': 'Firefox', 03:34:24 INFO - 'buildbot_json_path': 'buildprops.json', 03:34:24 INFO - 'code_coverage': False, 03:34:24 INFO - 'config_files': ('talos/linux_config.py',), 03:34:24 INFO - 'default_actions': ('clobber', 03:34:24 INFO - 'read-buildbot-config', 03:34:24 INFO - 'download-and-extract', 03:34:24 INFO - 'populate-webroot', 03:34:24 INFO - 'create-virtualenv', 03:34:24 INFO - 'install', 03:34:24 INFO - 'setup-mitmproxy', 03:34:24 INFO - 'run-tests'), 03:34:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:34:24 INFO - 'disable_ccov_upload': False, 03:34:24 INFO - 'download_minidump_stackwalk': True, 03:34:24 INFO - 'download_symbols': 'ondemand', 03:34:24 INFO - 'enable_stylo': False, 03:34:24 INFO - 'enable_webrender': False, 03:34:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:34:24 INFO - 'tooltool.py': '/tools/tooltool.py', 03:34:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:34:24 INFO - '/tools/misc-python/virtualenv.py')}, 03:34:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:34:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:34:24 INFO - 'gecko_profile': False, 03:34:24 INFO - 'gecko_profile_interval': 0, 03:34:24 INFO - 'installer_path': 'installer.exe', 03:34:24 INFO - 'log_level': 'info', 03:34:24 INFO - 'log_name': 'talos', 03:34:24 INFO - 'log_to_console': True, 03:34:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:34:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:34:24 INFO - 'opt_config_files': (), 03:34:24 INFO - 'pip_index': False, 03:34:24 INFO - 'suite': 'dromaeojs-e10s', 03:34:24 INFO - 'system_bits': '32', 03:34:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:34:24 INFO - 'title': 'talos-linux64-ix-049', 03:34:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:34:24 INFO - 'use_talos_json': True, 03:34:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:34:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:34:24 INFO - 'work_dir': 'build'} 03:34:24 INFO - [mozharness: 2017-08-16 10:34:24.894652Z] Running clobber step. 03:34:24 INFO - Running pre-action listener: _resource_record_pre_action 03:34:24 INFO - Running main action method: clobber 03:34:24 INFO - rmtree: /builds/slave/test/build 03:34:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:34:25 INFO - Running post-action listener: _resource_record_post_action 03:34:25 INFO - [mozharness: 2017-08-16 10:34:25.939273Z] Finished clobber step (success) 03:34:25 INFO - [mozharness: 2017-08-16 10:34:25.939375Z] Running read-buildbot-config step. 03:34:25 INFO - Running pre-action listener: _resource_record_pre_action 03:34:25 INFO - Running main action method: read_buildbot_config 03:34:25 INFO - Using buildbot properties: 03:34:25 INFO - { 03:34:25 INFO - "project": "", 03:34:25 INFO - "product": "firefox", 03:34:25 INFO - "who": "cbook@mozilla.com", 03:34:25 INFO - "installer_path": "public/build/target.tar.bz2", 03:34:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 03:34:25 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:34:25 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 03:34:25 INFO - "stage_platform": "linux64-stylo", 03:34:25 INFO - "basedir": "/builds/slave/test", 03:34:25 INFO - "buildnumber": 36, 03:34:25 INFO - "platform": "ubuntu64_hw_stylo", 03:34:25 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:34:25 INFO - "slavebuilddir": "test", 03:34:25 INFO - "taskId": "d0VxkXaTR9SqrGIpMr36JQ", 03:34:25 INFO - "branch": "mozilla-central", 03:34:25 INFO - "script_repo_revision": "production", 03:34:25 INFO - "revision": "6ebc251bd288c268b020815025b05854ccde5c08", 03:34:25 INFO - "slavename": "talos-linux64-ix-049", 03:34:25 INFO - "repo_path": "mozilla-central" 03:34:25 INFO - } 03:34:25 INFO - Finding installer, test and symbols from parent task. 03:34:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d0VxkXaTR9SqrGIpMr36JQ'}, attempt #1 03:34:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d0VxkXaTR9SqrGIpMr36JQ'}, attempt #1 03:34:26 INFO - Task dependencies: Ik1VZCnkRAKLMf_kMSI2Ig 03:34:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig'}, attempt #1 03:34:27 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig/artifacts/public/build/target.tar.bz2 03:34:27 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig/artifacts/public/build/target.test_packages.json 03:34:27 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig/artifacts/public/build/target.crashreporter-symbols.zip 03:34:27 INFO - Running post-action listener: _resource_record_post_action 03:34:27 INFO - [mozharness: 2017-08-16 10:34:27.331759Z] Finished read-buildbot-config step (success) 03:34:27 INFO - [mozharness: 2017-08-16 10:34:27.331985Z] Running download-and-extract step. 03:34:27 INFO - Running pre-action listener: _resource_record_pre_action 03:34:27 INFO - Running main action method: download_and_extract 03:34:27 INFO - mkdir: /builds/slave/test/build/tests 03:34:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:27 INFO - trying https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig/artifacts/public/build/target.test_packages.json 03:34:27 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:34:27 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:34:27 INFO - Downloaded 989 bytes. 03:34:27 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:34:27 INFO - Using the following test package requirements: 03:34:27 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:34:27 INFO - u'common': [u'target.common.tests.zip'], 03:34:27 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:34:27 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:34:27 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:34:27 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:34:27 INFO - u'mozbase': [u'target.common.tests.zip'], 03:34:27 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:34:27 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:34:27 INFO - u'web-platform': [u'target.common.tests.zip', 03:34:27 INFO - u'target.web-platform.tests.tar.gz'], 03:34:27 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:34:27 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:34:27 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:34:27 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:34:27 INFO - Fetch https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig/artifacts/public/build/target.common.tests.zip into memory 03:34:29 INFO - Content-Length response header: 54003804 03:34:29 INFO - Bytes received: 54003804 03:34:39 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:34:39 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:34:39 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:34:39 INFO - Fetch https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig/artifacts/public/build/target.common.tests.zip into memory 03:34:41 INFO - Content-Length response header: 54003804 03:34:41 INFO - Bytes received: 54003804 03:34:53 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:34:53 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:34:53 INFO - Fetch https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig/artifacts/public/build/target.talos.tests.zip into memory 03:34:53 INFO - Content-Length response header: 14496050 03:34:53 INFO - Bytes received: 14496050 03:34: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:34:54 INFO - trying https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig/artifacts/public/build/target.tar.bz2 03:34:54 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:34:54 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:34:55 INFO - Downloaded 61804821 bytes. 03:34:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig/artifacts/public/build/target.tar.bz2 03:34:55 INFO - mkdir: /builds/slave/test/properties 03:34:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:34:55 INFO - Writing to file /builds/slave/test/properties/build_url 03:34:55 INFO - Contents: 03:34:55 INFO - build_url:https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig/artifacts/public/build/target.tar.bz2 03:34:55 INFO - Running post-action listener: _resource_record_post_action 03:34:55 INFO - Running post-action listener: set_extra_try_arguments 03:34:55 INFO - [mozharness: 2017-08-16 10:34:55.124864Z] Finished download-and-extract step (success) 03:34:55 INFO - [mozharness: 2017-08-16 10:34:55.124963Z] Running populate-webroot step. 03:34:55 INFO - Running pre-action listener: _resource_record_pre_action 03:34:55 INFO - Running main action method: populate_webroot 03:34:55 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:34:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:34:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:34:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:34:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:34:55 INFO - 'tests': ['damp', 'tps']}, 03:34:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:34:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:34:55 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:34:55 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:34:55 INFO - 'other-e10s': {'tests': ['a11yr', 03:34:55 INFO - 'ts_paint', 03:34:55 INFO - 'tpaint', 03:34:55 INFO - 'sessionrestore', 03:34:55 INFO - 'sessionrestore_many_windows', 03:34:55 INFO - 'sessionrestore_no_auto_restore', 03:34:55 INFO - 'tabpaint']}, 03:34:55 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:34:55 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:34:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:34:55 INFO - 'tsvgr_opacity', 03:34:55 INFO - 'tart', 03:34:55 INFO - 'tscrollx', 03:34:55 INFO - 'tsvg_static']}, 03:34:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:34:55 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:34:55 INFO - 'talos_options': ['--mitmproxy', 03:34:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:34:55 INFO - '--firstNonBlankPaint'], 03:34:55 INFO - 'tests': ['tp6_google', 03:34:55 INFO - 'tp6_youtube', 03:34:55 INFO - 'tp6_amazon', 03:34:55 INFO - 'tp6_facebook']}, 03:34:55 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:34:55 INFO - 'talos_options': ['--stylo', 03:34:55 INFO - '--mitmproxy', 03:34:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:34:55 INFO - '--firstNonBlankPaint'], 03:34:55 INFO - 'tests': ['tp6_google', 03:34:55 INFO - 'tp6_youtube', 03:34:55 INFO - 'tp6_amazon', 03:34:55 INFO - 'tp6_facebook']}, 03:34:55 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:34:55 INFO - 'talos_options': ['--stylo', 03:34:55 INFO - '--stylo-threads=1', 03:34:55 INFO - '--mitmproxy', 03:34:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:34:55 INFO - '--firstNonBlankPaint'], 03:34:55 INFO - 'tests': ['tp6_google', 03:34:55 INFO - 'tp6_youtube', 03:34:55 INFO - 'tp6_amazon', 03:34:55 INFO - 'tp6_facebook']}, 03:34:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:34:55 INFO - 'talos_options': ['--xperf_path', 03:34:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:34:55 INFO - 'tests': ['tp5n']}}} 03:34:55 INFO - Running post-action listener: _resource_record_post_action 03:34:55 INFO - [mozharness: 2017-08-16 10:34:55.133547Z] Finished populate-webroot step (success) 03:34:55 INFO - [mozharness: 2017-08-16 10:34:55.133637Z] Running create-virtualenv step. 03:34:55 INFO - Running pre-action listener: _resource_record_pre_action 03:34:55 INFO - Running main action method: create_virtualenv 03:34:55 INFO - Creating virtualenv /builds/slave/test/build/venv 03:34:55 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:34:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:34:55 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:34:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:34:55 INFO - Using real prefix '/usr' 03:34:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:34:55 INFO - Installing distribute.............................................................................................................................................................................................done. 03:34:57 INFO - Installing pip.................done. 03:34:57 INFO - Return code: 0 03:34:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:34:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:34:57 INFO - Reading from file tmpfile_stdout 03:34:57 INFO - Output received: 03:34:57 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:34:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:34:57 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:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:57 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:34:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:57 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 0x25421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2646a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e9ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e70b0>, '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 0x27e7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e8440>, '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': 'db7e7c15f3ca076d53731445000001ba-1502879662.959386-1115570645', '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:34:57 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:34:57 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:34:57 INFO - Using env: {'DISPLAY': ':0', 03:34:57 INFO - 'HOME': '/home/cltbld', 03:34:57 INFO - 'LANG': 'en_US.UTF-8', 03:34:57 INFO - 'LANGUAGE': 'en_US:en', 03:34:57 INFO - 'LOGNAME': 'cltbld', 03:34:57 INFO - 'MAIL': '/var/mail/cltbld', 03:34:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:57 INFO - 'MOZ_NO_REMOTE': '1', 03:34:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:57 INFO - 'NO_EM_RESTART': '1', 03:34:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:57 INFO - 'PWD': '/builds/slave/test', 03:34:57 INFO - 'SHELL': '/bin/bash', 03:34:57 INFO - 'SHLVL': '1', 03:34:57 INFO - 'TERM': 'linux', 03:34:57 INFO - 'TMOUT': '86400', 03:34:57 INFO - 'USER': 'cltbld', 03:34:57 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1502879662.959386-1115570645', 03:34:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:57 INFO - '_': '/tools/buildbot/bin/python'} 03:34:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:58 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:34:58 INFO - Cleaning up... 03:34:58 INFO - Return code: 0 03:34:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:34:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2646a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e9ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e70b0>, '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 0x27e7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e8440>, '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': 'db7e7c15f3ca076d53731445000001ba-1502879662.959386-1115570645', '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:34:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:34:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:34:58 INFO - Using env: {'DISPLAY': ':0', 03:34:58 INFO - 'HOME': '/home/cltbld', 03:34:58 INFO - 'LANG': 'en_US.UTF-8', 03:34:58 INFO - 'LANGUAGE': 'en_US:en', 03:34:58 INFO - 'LOGNAME': 'cltbld', 03:34:58 INFO - 'MAIL': '/var/mail/cltbld', 03:34:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:58 INFO - 'MOZ_NO_REMOTE': '1', 03:34:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:58 INFO - 'NO_EM_RESTART': '1', 03:34:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:58 INFO - 'PWD': '/builds/slave/test', 03:34:58 INFO - 'SHELL': '/bin/bash', 03:34:58 INFO - 'SHLVL': '1', 03:34:58 INFO - 'TERM': 'linux', 03:34:58 INFO - 'TMOUT': '86400', 03:34:58 INFO - 'USER': 'cltbld', 03:34:58 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1502879662.959386-1115570645', 03:34:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:58 INFO - '_': '/tools/buildbot/bin/python'} 03:34:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:58 INFO - Downloading/unpacking psutil>=3.1.1 03:34:58 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:34:58 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:34:58 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:34:58 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:34:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:34:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:34:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:34:59 INFO - Installing collected packages: psutil 03:34:59 INFO - Running setup.py install for psutil 03:34:59 INFO - building 'psutil._psutil_linux' extension 03:34:59 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:34:59 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:34:59 INFO - building 'psutil._psutil_posix' extension 03:34:59 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:34:59 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:35:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:35:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:35:00 INFO - Successfully installed psutil 03:35:00 INFO - Cleaning up... 03:35:00 INFO - Return code: 0 03:35:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:35:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2646a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e9ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e70b0>, '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 0x27e7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e8440>, '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': 'db7e7c15f3ca076d53731445000001ba-1502879662.959386-1115570645', '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:35:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:35:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:35:00 INFO - Using env: {'DISPLAY': ':0', 03:35:00 INFO - 'HOME': '/home/cltbld', 03:35:00 INFO - 'LANG': 'en_US.UTF-8', 03:35:00 INFO - 'LANGUAGE': 'en_US:en', 03:35:00 INFO - 'LOGNAME': 'cltbld', 03:35:00 INFO - 'MAIL': '/var/mail/cltbld', 03:35:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:00 INFO - 'MOZ_NO_REMOTE': '1', 03:35:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:00 INFO - 'NO_EM_RESTART': '1', 03:35:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:00 INFO - 'PWD': '/builds/slave/test', 03:35:00 INFO - 'SHELL': '/bin/bash', 03:35:00 INFO - 'SHLVL': '1', 03:35:00 INFO - 'TERM': 'linux', 03:35:00 INFO - 'TMOUT': '86400', 03:35:00 INFO - 'USER': 'cltbld', 03:35:00 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1502879662.959386-1115570645', 03:35:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:00 INFO - '_': '/tools/buildbot/bin/python'} 03:35:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:35:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:35:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:35:02 INFO - Installing collected packages: mozsystemmonitor 03:35:02 INFO - Running setup.py install for mozsystemmonitor 03:35:02 INFO - Successfully installed mozsystemmonitor 03:35:02 INFO - Cleaning up... 03:35:02 INFO - Return code: 0 03:35:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2646a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e9ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e70b0>, '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 0x27e7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e8440>, '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': 'db7e7c15f3ca076d53731445000001ba-1502879662.959386-1115570645', '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:35:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:35:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:35:02 INFO - Using env: {'DISPLAY': ':0', 03:35:02 INFO - 'HOME': '/home/cltbld', 03:35:02 INFO - 'LANG': 'en_US.UTF-8', 03:35:02 INFO - 'LANGUAGE': 'en_US:en', 03:35:02 INFO - 'LOGNAME': 'cltbld', 03:35:02 INFO - 'MAIL': '/var/mail/cltbld', 03:35:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:02 INFO - 'MOZ_NO_REMOTE': '1', 03:35:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:02 INFO - 'NO_EM_RESTART': '1', 03:35:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:02 INFO - 'PWD': '/builds/slave/test', 03:35:02 INFO - 'SHELL': '/bin/bash', 03:35:02 INFO - 'SHLVL': '1', 03:35:02 INFO - 'TERM': 'linux', 03:35:02 INFO - 'TMOUT': '86400', 03:35:02 INFO - 'USER': 'cltbld', 03:35:02 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1502879662.959386-1115570645', 03:35:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:02 INFO - '_': '/tools/buildbot/bin/python'} 03:35:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:02 INFO - Downloading/unpacking jsonschema==2.5.1 03:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:35:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:35:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:04 INFO - Downloading functools32-3.2.3-2.tar.gz 03:35:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:35:04 INFO - warning: no files found matching '*.txt' 03:35:04 INFO - no previously-included directories found matching 'build' 03:35:04 INFO - no previously-included directories found matching 'dist' 03:35:04 INFO - no previously-included directories found matching '.git*' 03:35:04 INFO - Installing collected packages: jsonschema, functools32 03:35:04 INFO - Running setup.py install for functools32 03:35:04 INFO - warning: no files found matching '*.txt' 03:35:04 INFO - no previously-included directories found matching 'build' 03:35:04 INFO - no previously-included directories found matching 'dist' 03:35:04 INFO - no previously-included directories found matching '.git*' 03:35:04 INFO - Successfully installed jsonschema functools32 03:35:04 INFO - Cleaning up... 03:35:04 INFO - Return code: 0 03:35:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:35:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:04 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 0x25421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2646a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e9ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e70b0>, '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 0x27e7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e8440>, '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': 'db7e7c15f3ca076d53731445000001ba-1502879662.959386-1115570645', '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:35:04 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:35:04 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:35:04 INFO - Using env: {'DISPLAY': ':0', 03:35:04 INFO - 'HOME': '/home/cltbld', 03:35:04 INFO - 'LANG': 'en_US.UTF-8', 03:35:04 INFO - 'LANGUAGE': 'en_US:en', 03:35:04 INFO - 'LOGNAME': 'cltbld', 03:35:04 INFO - 'MAIL': '/var/mail/cltbld', 03:35:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:04 INFO - 'MOZ_NO_REMOTE': '1', 03:35:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:04 INFO - 'NO_EM_RESTART': '1', 03:35:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:04 INFO - 'PWD': '/builds/slave/test', 03:35:04 INFO - 'SHELL': '/bin/bash', 03:35:04 INFO - 'SHLVL': '1', 03:35:04 INFO - 'TERM': 'linux', 03:35:04 INFO - 'TMOUT': '86400', 03:35:04 INFO - 'USER': 'cltbld', 03:35:04 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1502879662.959386-1115570645', 03:35:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:04 INFO - '_': '/tools/buildbot/bin/python'} 03:35:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:35:04 INFO - Cleaning up... 03:35:04 INFO - Return code: 0 03:35:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:35:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:04 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 0x25421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2646a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e9ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e70b0>, '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 0x27e7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e8440>, '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': 'db7e7c15f3ca076d53731445000001ba-1502879662.959386-1115570645', '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:35:04 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:35:04 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:35:04 INFO - Using env: {'DISPLAY': ':0', 03:35:04 INFO - 'HOME': '/home/cltbld', 03:35:04 INFO - 'LANG': 'en_US.UTF-8', 03:35:04 INFO - 'LANGUAGE': 'en_US:en', 03:35:04 INFO - 'LOGNAME': 'cltbld', 03:35:04 INFO - 'MAIL': '/var/mail/cltbld', 03:35:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:04 INFO - 'MOZ_NO_REMOTE': '1', 03:35:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:04 INFO - 'NO_EM_RESTART': '1', 03:35:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:04 INFO - 'PWD': '/builds/slave/test', 03:35:04 INFO - 'SHELL': '/bin/bash', 03:35:04 INFO - 'SHLVL': '1', 03:35:04 INFO - 'TERM': 'linux', 03:35:04 INFO - 'TMOUT': '86400', 03:35:04 INFO - 'USER': 'cltbld', 03:35:04 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1502879662.959386-1115570645', 03:35:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:04 INFO - '_': '/tools/buildbot/bin/python'} 03:35:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:04 INFO - Downloading/unpacking blobuploader==1.2.4 03:35:04 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:35:04 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:35:04 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:35:04 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:35:05 INFO - Downloading blobuploader-1.2.4.tar.gz 03:35:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:35:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:35:05 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:35:05 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:35:05 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:35:05 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:35:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:35:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:35:06 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:35:06 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:35:06 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:35:06 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:35:06 INFO - Downloading docopt-0.6.1.tar.gz 03:35:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:35:06 INFO - Installing collected packages: blobuploader, requests, docopt 03:35:06 INFO - Running setup.py install for blobuploader 03:35:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:35:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:35:06 INFO - Running setup.py install for requests 03:35:06 INFO - Running setup.py install for docopt 03:35:06 INFO - Successfully installed blobuploader requests docopt 03:35:06 INFO - Cleaning up... 03:35:07 INFO - Return code: 0 03:35:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:35:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:07 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 0x25421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2646a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e9ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e70b0>, '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 0x27e7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e8440>, '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': 'db7e7c15f3ca076d53731445000001ba-1502879662.959386-1115570645', '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:35:07 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:35:07 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:35:07 INFO - Using env: {'DISPLAY': ':0', 03:35:07 INFO - 'HOME': '/home/cltbld', 03:35:07 INFO - 'LANG': 'en_US.UTF-8', 03:35:07 INFO - 'LANGUAGE': 'en_US:en', 03:35:07 INFO - 'LOGNAME': 'cltbld', 03:35:07 INFO - 'MAIL': '/var/mail/cltbld', 03:35:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:07 INFO - 'MOZ_NO_REMOTE': '1', 03:35:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:07 INFO - 'NO_EM_RESTART': '1', 03:35:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:07 INFO - 'PWD': '/builds/slave/test', 03:35:07 INFO - 'SHELL': '/bin/bash', 03:35:07 INFO - 'SHLVL': '1', 03:35:07 INFO - 'TERM': 'linux', 03:35:07 INFO - 'TMOUT': '86400', 03:35:07 INFO - 'USER': 'cltbld', 03:35:07 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1502879662.959386-1115570645', 03:35:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:07 INFO - '_': '/tools/buildbot/bin/python'} 03:35:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:35:07 INFO - Running setup.py (path:/tmp/pip-WgrXRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:35:07 INFO - Running setup.py (path:/tmp/pip-mxxBnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:35:07 INFO - Running setup.py (path:/tmp/pip-R9dQU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:35:07 INFO - Running setup.py (path:/tmp/pip-2tRZ7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:35:07 INFO - Running setup.py (path:/tmp/pip-tS3myx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:35:07 INFO - Running setup.py (path:/tmp/pip-anJA3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:35:07 INFO - Running setup.py (path:/tmp/pip-cSqWwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:35:07 INFO - Running setup.py (path:/tmp/pip-x6P1XA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:35:07 INFO - Running setup.py (path:/tmp/pip-gel_tR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:35:08 INFO - Running setup.py (path:/tmp/pip-U30z_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:35:08 INFO - Running setup.py (path:/tmp/pip-vcmIoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:35:08 INFO - Running setup.py (path:/tmp/pip-l4iWgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:35:08 INFO - Running setup.py (path:/tmp/pip-WIvYRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:35:08 INFO - Running setup.py (path:/tmp/pip-fVOnrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:35:08 INFO - Running setup.py (path:/tmp/pip-llKvO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:35:08 INFO - Running setup.py (path:/tmp/pip-uFq6ZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:35:08 INFO - Running setup.py (path:/tmp/pip-wJfqyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:35:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:35:08 INFO - Running setup.py install for manifestparser 03:35:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:35:08 INFO - Running setup.py install for mozcrash 03:35:08 INFO - Running setup.py install for mozdebug 03:35:08 INFO - Running setup.py install for mozdevice 03:35:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:35:08 INFO - Running setup.py install for mozfile 03:35:09 INFO - Running setup.py install for mozhttpd 03:35:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:35:09 INFO - Running setup.py install for mozinfo 03:35:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:35:09 INFO - Running setup.py install for mozInstall 03:35:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:35:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:35:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:35:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:35:09 INFO - Running setup.py install for mozleak 03:35:09 INFO - Running setup.py install for mozlog 03:35:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:35:09 INFO - Running setup.py install for moznetwork 03:35:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:35:09 INFO - Running setup.py install for mozprocess 03:35:09 INFO - Running setup.py install for mozprofile 03:35:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:35:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:35:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:35:09 INFO - Running setup.py install for mozrunner 03:35:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:35:10 INFO - Running setup.py install for mozscreenshot 03:35:10 INFO - Running setup.py install for moztest 03:35:10 INFO - Running setup.py install for mozversion 03:35:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:35:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:35:10 INFO - Cleaning up... 03:35:10 INFO - Return code: 0 03:35:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:35:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:10 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 0x25421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2646a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e9ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e70b0>, '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 0x27e7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e8440>, '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': 'db7e7c15f3ca076d53731445000001ba-1502879662.959386-1115570645', '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:35:10 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:35:10 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:35:10 INFO - Using env: {'DISPLAY': ':0', 03:35:10 INFO - 'HOME': '/home/cltbld', 03:35:10 INFO - 'LANG': 'en_US.UTF-8', 03:35:10 INFO - 'LANGUAGE': 'en_US:en', 03:35:10 INFO - 'LOGNAME': 'cltbld', 03:35:10 INFO - 'MAIL': '/var/mail/cltbld', 03:35:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:10 INFO - 'MOZ_NO_REMOTE': '1', 03:35:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:10 INFO - 'NO_EM_RESTART': '1', 03:35:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:10 INFO - 'PWD': '/builds/slave/test', 03:35:10 INFO - 'SHELL': '/bin/bash', 03:35:10 INFO - 'SHLVL': '1', 03:35:10 INFO - 'TERM': 'linux', 03:35:10 INFO - 'TMOUT': '86400', 03:35:10 INFO - 'USER': 'cltbld', 03:35:10 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1502879662.959386-1115570645', 03:35:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:10 INFO - '_': '/tools/buildbot/bin/python'} 03:35:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:35:10 INFO - Running setup.py (path:/tmp/pip-MzNviG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:35:10 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:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:35:10 INFO - Running setup.py (path:/tmp/pip-wfA7ek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:35:10 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:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:35:10 INFO - Running setup.py (path:/tmp/pip-Q9b0sz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:35:10 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:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:35:10 INFO - Running setup.py (path:/tmp/pip-4BvJZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:35:10 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:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:35:10 INFO - Running setup.py (path:/tmp/pip-eEiqcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:35:10 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:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:35:10 INFO - Running setup.py (path:/tmp/pip-JFuSlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:35:11 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:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:35:11 INFO - Running setup.py (path:/tmp/pip-g8Nrgr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:35:11 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:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:35:11 INFO - Running setup.py (path:/tmp/pip-YHEK5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:35:11 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:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:35:11 INFO - Running setup.py (path:/tmp/pip-ixkGwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:35:11 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:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:35:11 INFO - Running setup.py (path:/tmp/pip-hAqY_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:35:11 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:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:35:11 INFO - Running setup.py (path:/tmp/pip-S3cSFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:35:11 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:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:35:11 INFO - Running setup.py (path:/tmp/pip-0EzYGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:35:11 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:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:35:11 INFO - Running setup.py (path:/tmp/pip-hhhpF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:35:11 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:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:35:11 INFO - Running setup.py (path:/tmp/pip-IcNR3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:35:11 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:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:35:11 INFO - Running setup.py (path:/tmp/pip-EAZk_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:35:11 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:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:35:11 INFO - Running setup.py (path:/tmp/pip-HiRK1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:35:11 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:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:35:11 INFO - Running setup.py (path:/tmp/pip-3Uyc2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:35:11 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:35:11 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:35:11 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:35:11 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:35:11 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:35:11 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:35:11 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:35:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:35:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:12 INFO - Downloading blessings-1.6.tar.gz 03:35:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:35:13 INFO - Installing collected packages: blessings 03:35:13 INFO - Running setup.py install for blessings 03:35:13 INFO - Successfully installed blessings 03:35:13 INFO - Cleaning up... 03:35:13 INFO - Return code: 0 03:35:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:35:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:35:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:35:13 INFO - Reading from file tmpfile_stdout 03:35:13 INFO - Current package versions: 03:35:13 INFO - argparse == 1.2.1 03:35:13 INFO - blessings == 1.6 03:35:13 INFO - blobuploader == 1.2.4 03:35:13 INFO - docopt == 0.6.1 03:35:13 INFO - functools32 == 3.2.3-2 03:35:13 INFO - jsonschema == 2.5.1 03:35:13 INFO - manifestparser == 1.1 03:35:13 INFO - mozInstall == 1.13 03:35:13 INFO - mozcrash == 1.0 03:35:13 INFO - mozdebug == 0.1 03:35:13 INFO - mozdevice == 0.51 03:35:13 INFO - mozfile == 1.2 03:35:13 INFO - mozhttpd == 0.7 03:35:13 INFO - mozinfo == 0.10 03:35:13 INFO - mozleak == 0.1 03:35:13 INFO - mozlog == 3.5 03:35:13 INFO - moznetwork == 0.27 03:35:13 INFO - mozprocess == 0.25 03:35:13 INFO - mozprofile == 0.28 03:35:13 INFO - mozrunner == 6.13 03:35:13 INFO - mozscreenshot == 0.1 03:35:13 INFO - mozsystemmonitor == 0.3 03:35:13 INFO - moztest == 0.8 03:35:13 INFO - mozversion == 1.4 03:35:13 INFO - psutil == 3.1.1 03:35:13 INFO - requests == 1.2.3 03:35:13 INFO - wsgiref == 0.1.2 03:35:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:35:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:13 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 0x25421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2646a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e9ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e70b0>, '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 0x27e7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e8440>, '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': 'db7e7c15f3ca076d53731445000001ba-1502879662.959386-1115570645', '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:35:13 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:35:13 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:35:13 INFO - Using env: {'DISPLAY': ':0', 03:35:13 INFO - 'HOME': '/home/cltbld', 03:35:13 INFO - 'LANG': 'en_US.UTF-8', 03:35:13 INFO - 'LANGUAGE': 'en_US:en', 03:35:13 INFO - 'LOGNAME': 'cltbld', 03:35:13 INFO - 'MAIL': '/var/mail/cltbld', 03:35:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:13 INFO - 'MOZ_NO_REMOTE': '1', 03:35:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:13 INFO - 'NO_EM_RESTART': '1', 03:35:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:13 INFO - 'PWD': '/builds/slave/test', 03:35:13 INFO - 'SHELL': '/bin/bash', 03:35:13 INFO - 'SHLVL': '1', 03:35:13 INFO - 'TERM': 'linux', 03:35:13 INFO - 'TMOUT': '86400', 03:35:13 INFO - 'USER': 'cltbld', 03:35:13 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1502879662.959386-1115570645', 03:35:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:13 INFO - '_': '/tools/buildbot/bin/python'} 03:35:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:13 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:35:13 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:35:13 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:35:13 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:35:13 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:35:13 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:35:13 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:35:13 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:35:13 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:35:13 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:35:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:35:14 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:35:14 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:35:14 INFO - Installing collected packages: simplejson 03:35:14 INFO - Running setup.py install for simplejson 03:35:14 INFO - building 'simplejson._speedups' extension 03:35:14 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:35:15 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:35:15 INFO - Successfully installed simplejson 03:35:15 INFO - Cleaning up... 03:35:15 INFO - Return code: 0 03:35:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:15 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 0x25421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2646a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e9ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e70b0>, '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 0x27e7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e8440>, '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': 'db7e7c15f3ca076d53731445000001ba-1502879662.959386-1115570645', '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:35:15 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:35:15 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:35:15 INFO - Using env: {'DISPLAY': ':0', 03:35:15 INFO - 'HOME': '/home/cltbld', 03:35:15 INFO - 'LANG': 'en_US.UTF-8', 03:35:15 INFO - 'LANGUAGE': 'en_US:en', 03:35:15 INFO - 'LOGNAME': 'cltbld', 03:35:15 INFO - 'MAIL': '/var/mail/cltbld', 03:35:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:15 INFO - 'MOZ_NO_REMOTE': '1', 03:35:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:15 INFO - 'NO_EM_RESTART': '1', 03:35:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:15 INFO - 'PWD': '/builds/slave/test', 03:35:15 INFO - 'SHELL': '/bin/bash', 03:35:15 INFO - 'SHLVL': '1', 03:35:15 INFO - 'TERM': 'linux', 03:35:15 INFO - 'TMOUT': '86400', 03:35:15 INFO - 'USER': 'cltbld', 03:35:15 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1502879662.959386-1115570645', 03:35:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:15 INFO - '_': '/tools/buildbot/bin/python'} 03:35:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:35:16 INFO - Cleaning up... 03:35:16 INFO - Return code: 0 03:35:16 INFO - Running post-action listener: _resource_record_post_action 03:35:16 INFO - Running post-action listener: _start_resource_monitoring 03:35:16 INFO - Starting resource monitoring. 03:35:16 INFO - [mozharness: 2017-08-16 10:35:16.075164Z] Finished create-virtualenv step (success) 03:35:16 INFO - [mozharness: 2017-08-16 10:35:16.075679Z] Running install step. 03:35:16 INFO - Running pre-action listener: _resource_record_pre_action 03:35:16 INFO - Running main action method: install 03:35:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:35:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:35:16 INFO - Reading from file tmpfile_stdout 03:35:16 INFO - Detecting whether we're running mozinstall >=1.0... 03:35:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:35:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:35:16 INFO - Reading from file tmpfile_stdout 03:35:16 INFO - Output received: 03:35:16 INFO - Usage: mozinstall [options] installer 03:35:16 INFO - Options: 03:35:16 INFO - -h, --help show this help message and exit 03:35:16 INFO - -d DEST, --destination=DEST 03:35:16 INFO - Directory to install application into. [default: 03:35:16 INFO - "/builds/slave/test"] 03:35:16 INFO - --app=APP Application being installed. [default: firefox] 03:35:16 INFO - mkdir: /builds/slave/test/build/application 03:35:16 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:35:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:35:34 INFO - Reading from file tmpfile_stdout 03:35:34 INFO - Output received: 03:35:34 INFO - /builds/slave/test/build/application/firefox/firefox 03:35:34 INFO - Running post-action listener: _resource_record_post_action 03:35:34 INFO - [mozharness: 2017-08-16 10:35:34.369359Z] Finished install step (success) 03:35:34 INFO - [mozharness: 2017-08-16 10:35:34.369590Z] Running setup-mitmproxy step. 03:35:34 INFO - Running pre-action listener: _resource_record_pre_action 03:35:34 INFO - Running main action method: setup_mitmproxy 03:35:34 INFO - Skipping: mitmproxy is not required 03:35:34 INFO - Running post-action listener: _resource_record_post_action 03:35:34 INFO - [mozharness: 2017-08-16 10:35:34.370751Z] Finished setup-mitmproxy step (success) 03:35:34 INFO - [mozharness: 2017-08-16 10:35:34.370972Z] Running run-tests step. 03:35:34 INFO - Running pre-action listener: _resource_record_pre_action 03:35:34 INFO - Running pre-action listener: _set_gcov_prefix 03:35:34 INFO - Running main action method: run_tests 03:35:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:35:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:35:34 INFO - Python 2.7.3 03:35:34 INFO - Return code: 0 03:35:34 INFO - grabbing minidump binary from tooltool 03:35:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:34 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 0x27e70b0>, '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 0x27e7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e8440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:35:34 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:35:34 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:35:34 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:35:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:35:34 INFO - Return code: 0 03:35:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:35:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:35:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:35:34 INFO - ENV: RUST_BACKTRACE is now full 03:35:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:35:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:35:34 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-049', '--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:35:34 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-049 --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:35:34 INFO - Using env: {'DISPLAY': ':0', 03:35:34 INFO - 'HOME': '/home/cltbld', 03:35:34 INFO - 'LANG': 'en_US.UTF-8', 03:35:34 INFO - 'LANGUAGE': 'en_US:en', 03:35:34 INFO - 'LOGNAME': 'cltbld', 03:35:34 INFO - 'MAIL': '/var/mail/cltbld', 03:35:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:35:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:35:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:34 INFO - 'MOZ_NO_REMOTE': '1', 03:35:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:35:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:34 INFO - 'NO_EM_RESTART': '1', 03:35:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:34 INFO - 'PWD': '/builds/slave/test', 03:35:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:35:34 INFO - 'RUST_BACKTRACE': 'full', 03:35:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:35:34 INFO - 'SHELL': '/bin/bash', 03:35:34 INFO - 'SHLVL': '1', 03:35:34 INFO - 'STYLO_FORCE_ENABLED': '1', 03:35:34 INFO - 'TERM': 'linux', 03:35:34 INFO - 'TMOUT': '86400', 03:35:34 INFO - 'USER': 'cltbld', 03:35:34 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1502879662.959386-1115570645', 03:35:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:34 INFO - '_': '/tools/buildbot/bin/python'} 03:35:34 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-049', '--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:35:34 INFO - mozversion application_buildid: 20170816092342 03:35:34 INFO - mozversion application_changeset: 6ebc251bd288c268b020815025b05854ccde5c08 03:35:34 INFO - mozversion application_display_name: Nightly 03:35:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:35:34 INFO - mozversion application_name: Firefox 03:35:34 INFO - mozversion application_remotingname: firefox 03:35:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:35:34 INFO - mozversion application_vendor: Mozilla 03:35:34 INFO - mozversion application_version: 57.0a1 03:35:34 INFO - mozversion platform_buildid: 20170816092342 03:35:34 INFO - mozversion platform_changeset: 6ebc251bd288c268b020815025b05854ccde5c08 03:35:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:35:34 INFO - mozversion platform_version: 57.0a1 03:35:34 INFO - using testdate: 1502879734 03:35:34 INFO - actual date: 1502879734 03:35:34 INFO - starting webserver on 'localhost:53276' 03:35:34 INFO - SUITE-START | Running 2 tests 03:35:34 INFO - TEST-START | dromaeo_css 03:35:34 INFO - Initialising browser for dromaeo_css test... 03:35:34 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53276/getInfo.html -profile /tmp/tmp6eVFgA/profile 03:35:34 INFO - TEST-INFO | started process 23579 (/builds/slave/test/build/application/firefox/firefox http://localhost:53276/getInfo.html) 03:35:40 INFO - TEST-INFO | 23579: exit 0 03:35:40 INFO - Browser initialized. 03:35:40 INFO - Running cycle 1/1 for dromaeo_css test... 03:35:40 INFO - TEST-INFO | started process 23813 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6eVFgA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:35:41 INFO - PID 23813 | 03:35:41 INFO - PID 23813 | (/builds/slave/test/build/application/firefox/firefox:23868): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:35:41 INFO - PID 23813 | 03:35:52 INFO - PID 23813 | RSS: Main: 167817216 03:35:52 INFO - PID 23813 | 03:38:51 INFO - PID 23813 | Cycle 1(1): loaded http://localhost:53276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53276/tests/dromaeo/cssquery-ext.html) 03:38:52 INFO - PID 23813 | RSS: Main: 174915584 03:38:52 INFO - PID 23813 | 03:41:54 INFO - PID 23813 | Cycle 1(1): loaded http://localhost:53276/tests/dromaeo/cssquery-ext.html (next: http://localhost:53276/tests/dromaeo/cssquery-jquery.html) 03:41:55 INFO - PID 23813 | RSS: Main: 172400640 03:41:55 INFO - PID 23813 | 03:44:56 INFO - PID 23813 | Cycle 1(1): loaded http://localhost:53276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53276/tests/dromaeo/cssquery-mootools.html) 03:44:57 INFO - PID 23813 | RSS: Main: 174542848 03:44:57 INFO - PID 23813 | 03:47:59 INFO - PID 23813 | Cycle 1(1): loaded http://localhost:53276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53276/tests/dromaeo/cssquery-prototype.html) 03:47:59 INFO - PID 23813 | RSS: Main: 173375488 03:47:59 INFO - PID 23813 | 03:51:03 INFO - PID 23813 | Cycle 1(1): loaded http://localhost:53276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53276/tests/dromaeo/cssquery-yui.html) 03:51:04 INFO - PID 23813 | RSS: Main: 176238592 03:51:04 INFO - PID 23813 | 03:54:06 INFO - PID 23813 | Cycle 1(1): loaded http://localhost:53276/tests/dromaeo/cssquery-yui.html (next: http://localhost:53276/tests/dromaeo/cssquery-dojo.html) 03:54:06 INFO - PID 23813 | RSS: Main: 176861184 03:54:06 INFO - PID 23813 | 03:54:06 INFO - PID 23813 | __start_tp_report 03:54:06 INFO - PID 23813 | _x_x_mozilla_page_load 03:54:06 INFO - PID 23813 | _x_x_mozilla_page_load_details 03:54:06 INFO - PID 23813 | |i|pagename|runs| 03:54:06 INFO - PID 23813 | |0;dojo.html;3152.464081106212;3188.713015828575;3194.728448081913;3216.195951012246;3225.8387080645975;6004.939950600493;6064.302605200403;6074.969625151868;6079.696015199239;6105.877882442354;6074.878502429949;6094.17728606638;6103.359147289537;6113.23584551931;6113.938860611393;5596.748146333425;5613.466720661551;5616.466435688603;5643.492085712285;5738.31140263169;5718.71406429679;5770.596058275923;5790.971045144768;5814.24414826072;5820.447057529528;5648.406917273689;5731.254936858202;5740.971295143498;5799.217105690741;5821.825345239649;5544.695041772701;5560.388357280696;5630.8029218977545;5674.914876276859;5701.6864072476;5567.3040869891265;5706.4864162225595;5706.800261990852;5710.77156913723;5721.427857214287;6131.846703832395;6132;6173.135760993465;6222.253329600431;6251.99968005117;6648.601083934979;6680.966595167041;6701.3968742812895;6721.193456785169;6724.226713927912;6701.564398314094;6745.08941292929;6765.661716914184;6768.424683901874;6773.864522709568;6174.413430724074;6194.4425001749605;6265;6277.18396608438;6281.309056003836;6694.899576506356;6811.931880681229;6848.075509806113;6919.065926099912;6922.2731613180895;6470.320616335217;6470.45001174896;6472.676366181766;6476.805695829133;6477.514186436036;6520.804375868732;6535.934640653628;6545.345465453416;6551.639659818756;6563.704633291513;6660.533762636569;6685.6322902240845;6690.364415380531;6696.732130714814;6710.127683401127;6672.499562532829;6732.831679208059;6735.730570777212;6743.9325606743305;6756.4932630052945;5473.8357849264585;5474.315710536183;5532.917006244909;5549.306336707911;5560.110382338807;4512.390827238347;4563.771811409416;4622.237330840441;4671.135839869635;4692.718436893797;5808.3901190375245;5831.2127862738835;5834.27071616048;5841.591088623755;5854.034084376115;6698.933010669928;6707.027481015225;6764.763233286812;6795.490338224653;6797.66011699423;5799.420057994167;5836.708164591753;5868.295804503401;5875.148103524965;5913.46778789911;5841.065429531254;5866.384029676822;5911.970440147772;5915.349311575723;5996.850078748066;6444.968804991179;6465;6482.837929051717;6487.124238227779;6497.545171837926;6501.2198536175965;6583.572067815577;6589.769358072444;6600.174978127734;6618.139641846529;6418.19772528434;6422.614643121427;6463.547551671338;6483.546151769331;6567.540272181092;6307.558470906993;6541.051547525677;6561.114249576246;6644.60132392058;6646.966765166143;6527.477801775752;6617.900731489128;6694.866102678016;6794.66026698673;6795.28649491816;6343.714532846126;6353.841153971003;6354.4281014708895;6410.358964103739;6416.582922110048;6389.361063893573;6390.169277993831;6417.903731443938;6420.454261387835;6434;5618.831435056954;6163.260408750979;6344.1118243445035;6353.428191462791;6520.576162549419;6543.247526534319;6565.146530950946;6600.867982640416;6652.966735166293;6661.367170118831;6188.102725104744;6270.498360131087;6272.5922815016875;6330.49356051524;6442.677866106582 03:54:06 INFO - PID 23813 | |1;ext.html;777.6539439949225;806.491910096639;820.7086484298073;841.3689732700473;852.318145483613;39671.80164099179;40111.39832902509;40363.596364036384;40385.1922961541;40412.39381409274;36823.4476482853;36982.70560530382;37283.4407483888;37287.62712372875;37358;6595.175603049631;6702.698378572952;6704.229013663442;6704.363085506869;6705.865882682343;6594.4065034146915;6671.199456065279;6677.5325727199115;6677.899831502531;6678.966605166992;7421.554706717588;7585.241475852398;7591.582462964535;7605.733799317025;7610.505317154395;7503.024606801108;7546.584937828417;7552.169261381244;7553.999999999973;7555.508891922007;7294.781156565258;7355.705771769123;7445.739399121005;7447.813804654873;7464.589447580381;37471.43792843109;37716.24567508662;37771.24457510834;37903.62096379029;37904.620953790385;3538.7345949053665;3577.4454959481322;3580.3018411409785;3590.5152804371596;3594.6405359464106;30758.23104422385;30802.69197308043;30952.380952381052;30959.69040309613;31110.222244443845;4706.788194531255;4712.3167140764735;4720.0559888022535;4732.550407711262;4735.408073990751;185074;189505;192400;192455;207645;48784.26823597649;48805;48906;49088.26367604489;49427.50572494301;51420;51528.22707659388;51605.45183644497;51613.483865161616;51628.22557661638;16310.347586096423;16386;16425.507234782977;16434.342626294816;16559.91720041392;13613.52352667652;13619.659508512366;13630.659233519242;13631.522896698767;13646.658833529043;14126;14215.147091174562;14243.145411275356;14249.287535623178;14338.56984290452;5796.594238403356;5803.622764520293;5927.881442371215;5938.109283607493;5972.25346831646;981.4209616326401;990.4503000834605;1002.8395456727035;1005.7737009173023;1014.5535964175739;22557.66163507549;22579.322620321418;22732.772672273397;22746;22798.31605051851;1084.4631907205826;1084.4957094950885;1092.5192915117323;1093.4150229627112;1106.1095817866533;12137.514499419924;12502.249865008129;12514.18657787241;12567.811482827765;12580.748385032248;244019;245634;245732;246029;246223;51561;51804.48195518072;52033.21950170751;52200.477995220324;52325.2151217732;1451.8185226846645;1465.479754687092;1510.7280689476;1513.4248985385484;1517.9089254644757;22641.660375094056;22781.658275125556;22832.543349133255;22944.196953106562;23114.422139446648;35770.10574735652;35832.28335433225;35850.64149358473;35868.820655896554;35925.64074359328;195412;198831;199321;199368;199535;33585.496217557244;35508.82245588859;37453.62546374501;37469.81265093657;37534.06164845901;46538.534614654774;46920.29619555778;47314.29028564643;47492;47712.5228747722;34523.30953380968;34711.305773883876;34735;34862.30275394529;35036.474452882714;33591.66408335983;33681.494777578846;33843.3231335367;33944.3211135771;34258.48612270868;37537;37600.81199593985;37844.810775947044;37958.62041379551;38048.048798780255;32535.349293013533;32618.51072233966;32628.184295392806;32653.673463265062;32770.67229327676;24354.081326806016;24693.382665433506;24812.131575394775;25043.12349067774;25097.498050039263 03:54:06 INFO - PID 23813 | |2;jquery.html;557.9776808927643;568.4912003756638;569.5557465177163;572.6678526454657;582.8309790160854;21903;22532;22684.319470415874;22696.65955010672;22718.091276348947;26670.866645666745;27452.313692157706;27551;27576.862115689444;27583.724162758368;6439.549231553793;6587.275399706053;6592.110065141216;6594.8681026379445;6601.339866013408;6400.487960963112;6471.5146364022885;6971.7559885404025;7021.9297807021785;7023.051887995106;6989.860202795941;7026.754063607775;7036.7185312587435;7040.6831692573705;7048.154221493428;7044.753433629824;7049.118860142482;7051.92948070523;7054.541454805421;7056.823579410505;6892.827679308058;6917.792466226021;6918.342757438086;6922.7923162305215;6942.201646810631;31187.532187017212;31929.52105718416;32529.837350813094;32827.50758738621;32838;1952.8828270303827;1973.0430741090559;1978.238378224394;1985.6922177062434;1987.076009655517;19687;20292;20316.492087697778;20496.5900681987;20510.38468845922;2487.4030232744194;2494.625806129095;2521.962170567443;2588.7022992355933;2602.778763805079;135561.32219338938;139463;139534;139558.30220848933;139936.30031849776;21246.78753212479;22393.44016399603;22820;22867.428314292276;22953.7704622955;22998.42503937415;24215.636765448533;24259;24304.878475607507;44626.55373446224;10104.242181836391;10257.38455692646;10326.638567650247;10414.823478838875;10444.268901176996;9397.436153830791;9458.95270523643;9471.431714097176;9512.429254244767;9540.904590954002;9696.224302055818;9798.363106398061;9848.06443387877;9938.801223975624;10011.199104071657;2788.288986308519;2805.116388337708;2833.461642288;2882.1497658190883;2890.59531665567;955.6846240740539;976.72651657536;978.7846673731767;982.4203719805349;992.34009383759;19613.41159765209;19898.801011989985;20097.799022009884;20130.798692012893;20310.49223769388;1036.533559898049;1043.9739006524746;1046.6075221791828;1049.4490392543823;1050.5167622893555;11196.832047519294;11243.60647377338;11254.493547790205;11334.943325283486;11365.488553015135;468590;471323;478117;481232;482131;115876.42061789805;117081.4145929282;118148;118496.40751796185;118681;1176.5940750441084;1188.3464094747853;1213.0416970593133;1214.817777333407;1225.4485481533168;17224.224909878834;17444.47666570005;17587.472375828747;17589.82410175882;17977.73033404474;57152.142717858434;57658.7117064412;58029.709851450476;59509.40490595212;62324.688376557824;68217.65891170711;68689;68731.31268687449;68746;69233;14648.414063437343;15089.698206036037;15142.54572362831;15196.088234705952;15196.468123615621;23698.170564030177;23720.169794057125;23913.282601521983;24027.27918162458;24071.398215044763;18659.60052996058;19550.413487595393;19587.314443994394;19611.411657650293;19849;17299.13504324804;17467.03931283741;17708.822911771233;17737.201825918124;18458.907705461923;19683.507912302306;19918;20271.59456810826;20389.082491288224;20446.693299600814;14583.125012499284;14881.25593720288;15195.164265965035;15221.771673424686;15252.847471525143;19412.70880936759;19580.11889465006;19618.313359032367;19711.310104146287;19716.309929152412 03:54:06 INFO - PID 23813 | |3;mootools.html;1383.5157694806817;1439.460202424091;1445.9710805783889;1450.4778279819257;1451.027811366385;14217.92891035546;14225.715485690293;14806.703865922702;14856.92571537142;14857.40570377185;14989.550313490612;15231.771523427129;15236.466723664675;15242.695146097072;15262.236888155576;2530.5192013517417;2572.9228123156336;2573;2576.716561178269;2582.018832843517;2676.611891275764;2692.569188929772;2730.194592595179;2730.84980326083;2731.4537092581563;2677.4377380750066;2701.594760785888;2711.376383431812;2727.059164588214;2727.8772455239464;2633.9341516462146;2640.471905618874;2651.893924243028;2651.9867400662874;2658.8537630430415;2578.2909699832508;2589.766920977121;2602.4795040991876;2611.7127116017223;2612.3207965928805;14134.15195088298;14222.146671199762;14346.42614295427;14350;14363.784543231859;7445.8510829783645;7456.440766942501;7705.190954949761;7711.652975616111;7754.689812407497;4869.196582563908;5055.545000949895;5161.845144645667;5172.560332371753;5188.22176673502;1887.282832523646;1892.8674992750514;1902.7431296774896;1937.3509874192162;1947.8928658923753;22977.65533516982;23109.653355199687;23167.652485212737;23348.533029339316;23918.760812392;6318.431341179224;6320.589161704566;6547.476201903836;6573.1783527059115;6580.045893345534;16530.0908450034;16539.090350030863;16581.91709041447;16600.916995414944;16606.584835379213;7606.847863042708;7717.768466946;7733.690652373954;7751.418643601753;7760.883586746203;5567.4432556744005;5976.880462390728;6070.0591408331775;6080.9391906081255;7130.572165670076;4924.3105965164905;5049.697018178847;5133.974330128325;5146.562542183881;5166.689998600096;1477.6453651123652;1480.7704805755125;1491.2990894279671;1493.5444689369847;1514.5834895403852;878.2578720980761;900.7883147460342;906.2930913887178;910.5128756115579;915.6428992692855;7058.588581841743;7212.423006159494;7224.819379515554;7273.908913662993;7375.44684148691;690.4614400767409;702.455596912397;703.6763088979127;710.9715611375591;716.3624374306871;4446.110777844444;4458.108378324348;4463.419755431773;4535.705179163344;5131.589472842238;19787.20851165966;20286.69569956452;20364.49088772763;20870.37388878336;20976.895115524323;20347.8982605089;20470.488237794176;20540.07569659369;20715.58568828645;20755.481112972295;10695.679129626124;11093;11094.278871873303;11251.381174035343;11274.041706455044;7721.150673425806;8063.072746634212;8230.588470576567;8358.958205208935;8406.075331713384;16325.183740813149;16516;16544.917275413547;16557.91721041387;17003.91498042502;17648.294068237126;17766.733498997266;17933.820661793216;18001.549961251072;18032.278708852024;11644.88355116472;11787.587434439753;11882.10884183707;11892;11892.762144756884;13421.194728316332;13437.596872093853;13557.118787278796;13582.728345432839;13663.521776737767;10959;10990.08469633421;11030.28303160292;11212.15908806859;11408.71478213018;11133.55465781392;11141.72145696364;11185.32888026721;11274;11408.315501069963;9393.577289021874;9475.952620236854;9584.089511496397;9603.807923841623;9607.711768646952;7140.821479463055;7160.534565253241;7174.713011479483;7193.100862392201;7232.602206878672;6843.555168914005;6849.691763870737;7010.900516550633;7042.859142817012;7078.787636370917 03:54:06 INFO - PID 23813 | |4;prototype.html;486.82040108329346;495.7594334741107;516.6409345504874;517.5781737883627;519.6803965561179;6069.9999999999945;6220.502359811216;6243.500519958404;6248.9062664060075;6258.780942667007;5814.296352196228;6069.150318955339;6105.664188469633;6137.26352837659;6146.8463288417815;4975.278584605248;4975.3283306753665;4976.328195693589;4989.675671081377;5016.974915125419;4975.437649610453;4977.850664480054;5000.874978125539;5038.622103342264;5041.1178043842365;4774.450938142123;4927.433345165298;4932.432770231416;4941.827036053739;4945.18404463265;4931.309616653672;4938.950610493903;4966.081274964144;5002.59979201663;5031.597472202215;4449.221386257392;4452.48796388413;4454.621357184643;4467.352233926063;4473.4408198975125;6045.72794224261;6047.7278522466595;6055.698024924663;6069.908951365733;6082.300535438437;5668.263125793662;5676.403977582336;5689;5734.369219385864;5760.423957604206;6337.2395312562785;6442.581232219891;6498.187726534184;6519.478441724698;6580.901286480706;4841.878953026203;4858.514148585114;4898.608111351084;4899.1426500362295;4904.852854414374;6878.621675807829;6928.896066558956;6945.89581156283;6963.8607227855155;6985.882258838561;4953.578945789576;4971.65198436106;5002.52476014778;5007.674501157413;5041.974790126026;5007.499250075036;5030.723310217973;5032.936496036607;5044.899102017939;5053.67151135175;5692.7722891083895;5705.2012718219485;5712.857178570569;5732.742026608813;5758.481736643638;6471.449926756279;6491.799017181742;6535.901961470582;6567.737290508422;6574.408303252731;1666.5833541614597;1688.729803231477;1698.8131305556378;1729.4725108841671;1765.8521960725375;1198.7063169523349;1215.6353094071744;1229.9631011069682;1233.9321337326353;1236.116176933497;5684.545236381162;5720.542356611461;5739.225204597409;5799.39106393831;5819.970900145472;6577.210734711865;6595.934040659532;6597.835054123685;6636.668166591651;6645.900311495331;5759.740811663485;5786.566007549451;5831.358550559435;5869.735861886225;5877.23595932526;3532.7350448716447;3545.4681797730545;3555.6888022785397;3583.3012562550575;3606.124815096188;6606.504512161511;6628.304028077079;6648.966755166193;6674.666266686646;6688.531802773759;6890.31096890307;6947.79156625302;7009.228984811667;7027.016217729522;7039.54242974205;6507.3731567108225;6515.315891831384;6641.402273795382;6643.867122657616;6680.298568650222;6716.1940567130305;6755.459563235027;6791.626460544718;6818.454523638196;6823.847994763922;6592.472602191909;6611.033379971978;6721.529492935448;6743.460523158234;6750.426213771884;6531.216254049545;6564.704588293443;6596.90104648421;6651.46788256948;6662.666866656745;4951.10880041596;4951.77717002743;4967.130752118293;4968.801247950041;4974.452810190948;6712.83217919556;6738.7304507819135;6756.155480564929;6766.729330826712;6769.796906092825;6359.872802544016;6429.292777794532;6532.706028228836;6552.6068435894;6554.868902621825;6436.549441539048;6489.902651460137;6543.476521878333;6558.278589355072;6577.408033277028;6238.344973777688;6270.181647322408;6396.456301214449;6399.520035997226;6474.838129046623;6546.639934803441;6546.803595892131;6589.967050164719;6603.80188594343;6623.2383275923885;6328.082428047999;6332.30344662096;6373.904391434225;6395.6802159890885;6398.168238129014 03:54:06 INFO - PID 23813 | |5;yui.html;913.2876356441977;925.1165137293884;929.8791157149569;933.6778811310099;957.105106725212;18836.152373143206;19788.60422791545;19950.401487955383;19967.10148043338;23015.19446819362;20461.590768184626;21996.230131945384;22541.774582254173;22543.661845072296;22546.43633909153;1041.9739506512342;1065;1072.0137473524376;1072.1744256922166;1072.9409882456462;1073.0771536478621;1075.5428942699361;1076.4994277660885;1076.8169411200115;1077.1006209814775;1124.3872089711126;1127.4193790198055;1127.9379634120162;1129.0177545535396;1129.3844854554247;1131.1120770195357;1132.898039176474;1133.6882357351753;1133.7222380516744;1134.5915470430639;821.1337039423406;822.1244374740942;822.2763967708378;823.3454403749034;823.555280148719;20370;20681.89659051695;20771.68842467364;20843.16627334905;20862.687059694115;21878.12487500498;21985.890070549704;22359.552808943892;22435.663465048037;22445.775542244533;16660.6667866642;16941.40705075329;17100.657986840317;17182.48452546413;17195.054272015033;3656.3784156693428;3693.4829123922673;3695.4087346024776;3701.0747313171705;3702.5742039665515;128380;129523.99999999905;130180;131038;132214;16796.664066718597;16828.326866925185;17218.827811721974;17220.65558688819;17232.396866109877;30798.84600576983;31134;31252.37495250128;31319.843400783306;31351.216219594236;7618.276263754934;8737.563121843883;8898.4660920345;9145.81708365829;9235.953820230856;4300.526942036374;4369.366441865912;4378.277584198635;4383.9342409863875;4385.758783266887;5324.094903866352;5413.377461591967;5434.130539113802;5798.130280457881;5987.64074155552;1063.5852017713098;1088.755030118217;1096.9177311701653;1100.1968562948932;1105.0772604874858;675.2707076357522;685.7428464325877;691.7302252121676;695.2664938489942;706.4948561778353;12315.876841231653;12423.875761242272;12533.874661253452;13296.468141274241;13330.466781328832;670.085333519742;674.6087269383746;675.4663815585633;676.6210921883761;677.6747161362573;5802.21670074543;6002.969985150046;6557.5081868860025;6564.901526477107;6649.60102393858;111721;111938.44030779957;114732;114767;116282;98017;100118;100305;101027.49486252668;101699;86924;89254.55372723094;90951;91804.54097729603;93257.533712331;12858.42137103814;13082.542111026069;13131.34343282813;13241.735165296834;13376.598702038955;38337.80831095938;38863.222735544565;38920.41619375655;39389.409158862065;40709;71269.28730712626;72393.27606723865;73073.26926730665;73361.16597085116;75034.62482687552;19216.903915480892;19320.227190912206;19334.903325483847;19429.12568934373;19608.215671372986;20191;20643.380698579065;20655.793442065988;20788;20878.269260575806;18360.173792179117;18521.166547505665;19934.900325498278;20042.699359509326;20492.590148196654;20399.592008159456;20558.177672892918;20583.38249852507;20609;20698.275560355316;17961.281548737905;18785.6242875139;19391.903040484707;19463.92948387852;19567.902160489677;12917.741645167232;13792.379342929391;14173.858261417254;14180.432782688576;14488.34802433914;14322.14067155974;14595.343209555807;14895.106293622417;14906.329215185126;15789.447369342477 03:54:06 INFO - PID 23813 | __end_tp_report 03:54:06 INFO - PID 23813 | __start_cc_report 03:54:06 INFO - PID 23813 | _x_x_mozilla_cycle_collect,388 03:54:06 INFO - PID 23813 | __end_cc_report 03:54:06 INFO - PID 23813 | __startTimestamp1502880846584__endTimestamp 03:54:06 INFO - PID 23813 | 03:54:06 INFO - PID 23813 | ------- Summary: start ------- 03:54:06 INFO - PID 23813 | Number of tests: 6 03:54:06 INFO - PID 23813 | 03:54:06 INFO - PID 23813 | [#0] dojo.html Cycles:165 Average:6124.40 Median:6343.71 stddev:709.90 (11.2%) stddev-sans-first:672.71 03:54:06 INFO - PID 23813 | Values: 3152.5 3188.7 3194.7 3216.2 3225.8 6004.9 6064.3 6075.0 6079.7 6105.9 6074.9 6094.2 6103.4 6113.2 6113.9 5596.7 5613.5 5616.5 5643.5 5738.3 5718.7 5770.6 5791.0 5814.2 5820.4 5648.4 5731.3 5741.0 5799.2 5821.8 5544.7 5560.4 5630.8 5674.9 5701.7 5567.3 5706.5 5706.8 5710.8 5721.4 6131.8 6132.0 6173.1 6222.3 6252.0 6648.6 6681.0 6701.4 6721.2 6724.2 6701.6 6745.1 6765.7 6768.4 6773.9 6174.4 6194.4 6265.0 6277.2 6281.3 6694.9 6811.9 6848.1 6919.1 6922.3 6470.3 6470.5 6472.7 6476.8 6477.5 6520.8 6535.9 6545.3 6551.6 6563.7 6660.5 6685.6 6690.4 6696.7 6710.1 6672.5 6732.8 6735.7 6743.9 6756.5 5473.8 5474.3 5532.9 5549.3 5560.1 4512.4 4563.8 4622.2 4671.1 4692.7 5808.4 5831.2 5834.3 5841.6 5854.0 6698.9 6707.0 6764.8 6795.5 6797.7 5799.4 5836.7 5868.3 5875.1 5913.5 5841.1 5866.4 5912.0 5915.3 5996.9 6445.0 6465.0 6482.8 6487.1 6497.5 6501.2 6583.6 6589.8 6600.2 6618.1 6418.2 6422.6 6463.5 6483.5 6567.5 6307.6 6541.1 6561.1 6644.6 6647.0 6527.5 6617.9 6694.9 6794.7 6795.3 6343.7 6353.8 6354.4 6410.4 6416.6 6389.4 6390.2 6417.9 6420.5 6434.0 5618.8 6163.3 6344.1 6353.4 6520.6 6543.2 6565.1 6600.9 6653.0 6661.4 6188.1 6270.5 6272.6 6330.5 6442.7 03:54:06 INFO - PID 23813 | 03:54:06 INFO - PID 23813 | [#1] ext.html Cycles:180 Average:38220.85 Median:35859.73 stddev:55477.80 (154.7%) stddev-sans-first:55562.19 03:54:06 INFO - PID 23813 | Values: 777.7 806.5 820.7 841.4 852.3 39671.8 40111.4 40363.6 40385.2 40412.4 36823.4 36982.7 37283.4 37287.6 37358.0 6595.2 6702.7 6704.2 6704.4 6705.9 6594.4 6671.2 6677.5 6677.9 6679.0 7421.6 7585.2 7591.6 7605.7 7610.5 7503.0 7546.6 7552.2 7554.0 7555.5 7294.8 7355.7 7445.7 7447.8 7464.6 37471.4 37716.2 37771.2 37903.6 37904.6 3538.7 3577.4 3580.3 3590.5 3594.6 30758.2 30802.7 30952.4 30959.7 31110.2 4706.8 4712.3 4720.1 4732.6 4735.4 185074.0 189505.0 192400.0 192455.0 207645.0 48784.3 48805.0 48906.0 49088.3 49427.5 51420.0 51528.2 51605.5 51613.5 51628.2 16310.3 16386.0 16425.5 16434.3 16559.9 13613.5 13619.7 13630.7 13631.5 13646.7 14126.0 14215.1 14243.1 14249.3 14338.6 5796.6 5803.6 5927.9 5938.1 5972.3 981.4 990.5 1002.8 1005.8 1014.6 22557.7 22579.3 22732.8 22746.0 22798.3 1084.5 1084.5 1092.5 1093.4 1106.1 12137.5 12502.2 12514.2 12567.8 12580.7 244019.0 245634.0 245732.0 246029.0 246223.0 51561.0 51804.5 52033.2 52200.5 52325.2 1451.8 1465.5 1510.7 1513.4 1517.9 22641.7 22781.7 22832.5 22944.2 23114.4 35770.1 35832.3 35850.6 35868.8 35925.6 195412.0 198831.0 199321.0 199368.0 199535.0 33585.5 35508.8 37453.6 37469.8 37534.1 46538.5 46920.3 47314.3 47492.0 47712.5 34523.3 34711.3 34735.0 34862.3 35036.5 33591.7 33681.5 33843.3 33944.3 34258.5 37537.0 37600.8 37844.8 37958.6 38048.0 32535.3 32618.5 32628.2 32653.7 32770.7 24354.1 24693.4 24812.1 25043.1 25097.5 03:54:06 INFO - PID 23813 | 03:54:06 INFO - PID 23813 | [#2] jquery.html Cycles:180 Average:35228.60 Median:22976.10 stddev:80409.48 (350.0%) stddev-sans-first:80592.92 03:54:06 INFO - PID 23813 | Values: 558.0 568.5 569.6 572.7 582.8 21903.0 22532.0 22684.3 22696.7 22718.1 26670.9 27452.3 27551.0 27576.9 27583.7 6439.5 6587.3 6592.1 6594.9 6601.3 6400.5 6471.5 6971.8 7021.9 7023.1 6989.9 7026.8 7036.7 7040.7 7048.2 7044.8 7049.1 7051.9 7054.5 7056.8 6892.8 6917.8 6918.3 6922.8 6942.2 31187.5 31929.5 32529.8 32827.5 32838.0 1952.9 1973.0 1978.2 1985.7 1987.1 19687.0 20292.0 20316.5 20496.6 20510.4 2487.4 2494.6 2522.0 2588.7 2602.8 135561.3 139463.0 139534.0 139558.3 139936.3 21246.8 22393.4 22820.0 22867.4 22953.8 22998.4 24215.6 24259.0 24304.9 44626.6 10104.2 10257.4 10326.6 10414.8 10444.3 9397.4 9459.0 9471.4 9512.4 9540.9 9696.2 9798.4 9848.1 9938.8 10011.2 2788.3 2805.1 2833.5 2882.1 2890.6 955.7 976.7 978.8 982.4 992.3 19613.4 19898.8 20097.8 20130.8 20310.5 1036.5 1044.0 1046.6 1049.4 1050.5 11196.8 11243.6 11254.5 11334.9 11365.5 468590.0 471323.0 478117.0 481232.0 482131.0 115876.4 117081.4 118148.0 118496.4 118681.0 1176.6 1188.3 1213.0 1214.8 1225.4 17224.2 17444.5 17587.5 17589.8 17977.7 57152.1 57658.7 58029.7 59509.4 62324.7 68217.7 68689.0 68731.3 68746.0 69233.0 14648.4 15089.7 15142.5 15196.1 15196.5 23698.2 23720.2 23913.3 24027.3 24071.4 18659.6 19550.4 19587.3 19611.4 19849.0 17299.1 17467.0 17708.8 17737.2 18458.9 19683.5 19918.0 20271.6 20389.1 20446.7 14583.1 14881.3 15195.2 15221.8 15252.8 19412.7 19580.1 19618.3 19711.3 19716.3 03:54:06 INFO - PID 23813 | 03:54:06 INFO - PID 23813 | [#3] mootools.html Cycles:180 Average:8880.67 Median:2585.89 stddev:6216.21 (240.4%) stddev-sans-first:6208.12 03:54:06 INFO - PID 23813 | Values: 1383.5 1439.5 1446.0 1450.5 1451.0 14217.9 14225.7 14806.7 14856.9 14857.4 14989.6 15231.8 15236.5 15242.7 15262.2 2530.5 2572.9 2573.0 2576.7 2582.0 2676.6 2692.6 2730.2 2730.8 2731.5 2677.4 2701.6 2711.4 2727.1 2727.9 2633.9 2640.5 2651.9 2652.0 2658.9 2578.3 2589.8 2602.5 2611.7 2612.3 14134.2 14222.1 14346.4 14350.0 14363.8 7445.9 7456.4 7705.2 7711.7 7754.7 4869.2 5055.5 5161.8 5172.6 5188.2 1887.3 1892.9 1902.7 1937.4 1947.9 22977.7 23109.7 23167.7 23348.5 23918.8 6318.4 6320.6 6547.5 6573.2 6580.0 16530.1 16539.1 16581.9 16600.9 16606.6 7606.8 7717.8 7733.7 7751.4 7760.9 5567.4 5976.9 6070.1 6080.9 7130.6 4924.3 5049.7 5134.0 5146.6 5166.7 1477.6 1480.8 1491.3 1493.5 1514.6 878.3 900.8 906.3 910.5 915.6 7058.6 7212.4 7224.8 7273.9 7375.4 690.5 702.5 703.7 711.0 716.4 4446.1 4458.1 4463.4 4535.7 5131.6 19787.2 20286.7 20364.5 20870.4 20976.9 20347.9 20470.5 20540.1 20715.6 20755.5 10695.7 11093.0 11094.3 11251.4 11274.0 7721.2 8063.1 8230.6 8359.0 8406.1 16325.2 16516.0 16544.9 16557.9 17003.9 17648.3 17766.7 17933.8 18001.5 18032.3 11644.9 11787.6 11882.1 11892.0 11892.8 13421.2 13437.6 13557.1 13582.7 13663.5 10959.0 10990.1 11030.3 11212.2 11408.7 11133.6 11141.7 11185.3 11274.0 11408.3 9393.6 9476.0 9584.1 9603.8 9607.7 7140.8 7160.5 7174.7 7193.1 7232.6 6843.6 6849.7 7010.9 7042.9 7078.8 03:54:06 INFO - PID 23813 | 03:54:06 INFO - PID 23813 | [#4] prototype.html Cycles:180 Average:5512.40 Median:6069.95 stddev:1556.08 (25.6%) stddev-sans-first:1514.03 03:54:06 INFO - PID 23813 | Values: 486.8 495.8 516.6 517.6 519.7 6070.0 6220.5 6243.5 6248.9 6258.8 5814.3 6069.2 6105.7 6137.3 6146.8 4975.3 4975.3 4976.3 4989.7 5017.0 4975.4 4977.9 5000.9 5038.6 5041.1 4774.5 4927.4 4932.4 4941.8 4945.2 4931.3 4939.0 4966.1 5002.6 5031.6 4449.2 4452.5 4454.6 4467.4 4473.4 6045.7 6047.7 6055.7 6069.9 6082.3 5668.3 5676.4 5689.0 5734.4 5760.4 6337.2 6442.6 6498.2 6519.5 6580.9 4841.9 4858.5 4898.6 4899.1 4904.9 6878.6 6928.9 6945.9 6963.9 6985.9 4953.6 4971.7 5002.5 5007.7 5042.0 5007.5 5030.7 5032.9 5044.9 5053.7 5692.8 5705.2 5712.9 5732.7 5758.5 6471.4 6491.8 6535.9 6567.7 6574.4 1666.6 1688.7 1698.8 1729.5 1765.9 1198.7 1215.6 1230.0 1233.9 1236.1 5684.5 5720.5 5739.2 5799.4 5820.0 6577.2 6595.9 6597.8 6636.7 6645.9 5759.7 5786.6 5831.4 5869.7 5877.2 3532.7 3545.5 3555.7 3583.3 3606.1 6606.5 6628.3 6649.0 6674.7 6688.5 6890.3 6947.8 7009.2 7027.0 7039.5 6507.4 6515.3 6641.4 6643.9 6680.3 6716.2 6755.5 6791.6 6818.5 6823.8 6592.5 6611.0 6721.5 6743.5 6750.4 6531.2 6564.7 6596.9 6651.5 6662.7 4951.1 4951.8 4967.1 4968.8 4974.5 6712.8 6738.7 6756.2 6766.7 6769.8 6359.9 6429.3 6532.7 6552.6 6554.9 6436.5 6489.9 6543.5 6558.3 6577.4 6238.3 6270.2 6396.5 6399.5 6474.8 6546.6 6546.8 6590.0 6603.8 6623.2 6328.1 6332.3 6373.9 6395.7 6398.2 03:54:06 INFO - PID 23813 | 03:54:06 INFO - PID 23813 | [#5] yui.html Cycles:180 Average:24686.61 Median:20477.09 stddev:33172.93 (162.0%) stddev-sans-first:33217.96 03:54:06 INFO - PID 23813 | Values: 913.3 925.1 929.9 933.7 957.1 18836.2 19788.6 19950.4 19967.1 23015.2 20461.6 21996.2 22541.8 22543.7 22546.4 1042.0 1065.0 1072.0 1072.2 1072.9 1073.1 1075.5 1076.5 1076.8 1077.1 1124.4 1127.4 1127.9 1129.0 1129.4 1131.1 1132.9 1133.7 1133.7 1134.6 821.1 822.1 822.3 823.3 823.6 20370.0 20681.9 20771.7 20843.2 20862.7 21878.1 21985.9 22359.6 22435.7 22445.8 16660.7 16941.4 17100.7 17182.5 17195.1 3656.4 3693.5 3695.4 3701.1 3702.6 128380.0 129524.0 130180.0 131038.0 132214.0 16796.7 16828.3 17218.8 17220.7 17232.4 30798.8 31134.0 31252.4 31319.8 31351.2 7618.3 8737.6 8898.5 9145.8 9236.0 4300.5 4369.4 4378.3 4383.9 4385.8 5324.1 5413.4 5434.1 5798.1 5987.6 1063.6 1088.8 1096.9 1100.2 1105.1 675.3 685.7 691.7 695.3 706.5 12315.9 12423.9 12533.9 13296.5 13330.5 670.1 674.6 675.5 676.6 677.7 5802.2 6003.0 6557.5 6564.9 6649.6 111721.0 111938.4 114732.0 114767.0 116282.0 98017.0 100118.0 100305.0 101027.5 101699.0 86924.0 89254.6 90951.0 91804.5 93257.5 12858.4 13082.5 13131.3 13241.7 13376.6 38337.8 38863.2 38920.4 39389.4 40709.0 71269.3 72393.3 73073.3 73361.2 75034.6 19216.9 19320.2 19334.9 19429.1 19608.2 20191.0 20643.4 20655.8 20788.0 20878.3 18360.2 18521.2 19934.9 20042.7 20492.6 20399.6 20558.2 20583.4 20609.0 20698.3 17961.3 18785.6 19391.9 19463.9 19567.9 12917.7 13792.4 14173.9 14180.4 14488.3 14322.1 14595.3 14895.1 14906.3 15789.4 03:54:06 INFO - PID 23813 | -------- Summary: end -------- 03:54:06 INFO - PID 23813 | 03:54:07 INFO - TEST-INFO | 23813: exit 0 03:54:07 INFO - TEST-OK | dromaeo_css | took 1112598ms 03:54:07 INFO - TEST-START | kraken 03:54:07 INFO - Initialising browser for kraken test... 03:54:07 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53276/getInfo.html -profile /tmp/tmpgeB9lh/profile 03:54:07 INFO - TEST-INFO | started process 24193 (/builds/slave/test/build/application/firefox/firefox http://localhost:53276/getInfo.html) 03:54:13 INFO - TEST-INFO | 24193: exit 0 03:54:13 INFO - Browser initialized. 03:54:13 INFO - Running cycle 1/1 for kraken test... 03:54:13 INFO - TEST-INFO | started process 24428 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgeB9lh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:54:14 INFO - PID 24428 | 03:54:14 INFO - PID 24428 | (/builds/slave/test/build/application/firefox/firefox:24483): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:54:14 INFO - PID 24428 | 03:54:24 INFO - PID 24428 | RSS: Main: 168562688 03:54:24 INFO - PID 24428 | 03:54:27 INFO - PID 24428 | Cycle 1(1): loaded http://localhost:53276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53276/tests/kraken/driver.html?testName=audio-beat-detection) 03:54:28 INFO - PID 24428 | RSS: Main: 174424064 03:54:28 INFO - PID 24428 | 03:54:31 INFO - PID 24428 | Cycle 1(1): loaded http://localhost:53276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53276/tests/kraken/driver.html?testName=audio-dft) 03:54:31 INFO - PID 24428 | RSS: Main: 178274304 03:54:31 INFO - PID 24428 | 03:54:34 INFO - PID 24428 | Cycle 1(1): loaded http://localhost:53276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53276/tests/kraken/driver.html?testName=audio-fft) 03:54:35 INFO - PID 24428 | RSS: Main: 172068864 03:54:35 INFO - PID 24428 | 03:54:37 INFO - PID 24428 | Cycle 1(1): loaded http://localhost:53276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53276/tests/kraken/driver.html?testName=audio-oscillator) 03:54:38 INFO - PID 24428 | RSS: Main: 172298240 03:54:38 INFO - PID 24428 | 03:54:40 INFO - PID 24428 | Cycle 1(1): loaded http://localhost:53276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:54:41 INFO - PID 24428 | RSS: Main: 172077056 03:54:41 INFO - PID 24428 | 03:54:44 INFO - PID 24428 | Cycle 1(1): loaded http://localhost:53276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53276/tests/kraken/driver.html?testName=imaging-darkroom) 03:54:44 INFO - PID 24428 | RSS: Main: 173699072 03:54:44 INFO - PID 24428 | 03:54:48 INFO - PID 24428 | Cycle 1(1): loaded http://localhost:53276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53276/tests/kraken/driver.html?testName=imaging-desaturate) 03:54:48 INFO - PID 24428 | RSS: Main: 173981696 03:54:48 INFO - PID 24428 | 03:54:51 INFO - PID 24428 | Cycle 1(1): loaded http://localhost:53276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53276/tests/kraken/driver.html?testName=json-parse-financial) 03:54:52 INFO - PID 24428 | RSS: Main: 174714880 03:54:52 INFO - PID 24428 | 03:54:54 INFO - PID 24428 | Cycle 1(1): loaded http://localhost:53276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:54:54 INFO - PID 24428 | RSS: Main: 174764032 03:54:54 INFO - PID 24428 | 03:54:56 INFO - PID 24428 | Cycle 1(1): loaded http://localhost:53276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53276/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:54:57 INFO - PID 24428 | RSS: Main: 174571520 03:54:57 INFO - PID 24428 | 03:54:59 INFO - PID 24428 | Cycle 1(1): loaded http://localhost:53276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:55:00 INFO - PID 24428 | RSS: Main: 174235648 03:55:00 INFO - PID 24428 | 03:55:02 INFO - PID 24428 | Cycle 1(1): loaded http://localhost:53276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:55:03 INFO - PID 24428 | RSS: Main: 174350336 03:55:03 INFO - PID 24428 | 03:55:06 INFO - PID 24428 | Cycle 1(1): loaded http://localhost:53276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:55:07 INFO - PID 24428 | RSS: Main: 174616576 03:55:07 INFO - PID 24428 | 03:55:09 INFO - PID 24428 | Cycle 1(1): loaded http://localhost:53276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53276/tests/kraken/driver.html?testName=ai-astar) 03:55:09 INFO - PID 24428 | RSS: Main: 175755264 03:55:09 INFO - PID 24428 | 03:55:09 INFO - PID 24428 | __start_tp_report 03:55:09 INFO - PID 24428 | _x_x_mozilla_page_load 03:55:09 INFO - PID 24428 | _x_x_mozilla_page_load_details 03:55:09 INFO - PID 24428 | |i|pagename|runs| 03:55:09 INFO - PID 24428 | |0;ai-astar;98;109;103;109;107;107;107;100;110;111 03:55:09 INFO - PID 24428 | |1;audio-beat-detection;155;117;139;178;117;153;141;128;173;120 03:55:09 INFO - PID 24428 | |2;audio-dft;163;162;163;168;162;162;163;165;165;163 03:55:09 INFO - PID 24428 | |3;audio-fft;76;75;78;175;93;76;75;77;158;83 03:55:09 INFO - PID 24428 | |4;audio-oscillator;79;86;129;83;82;85;133;86;79;134 03:55:09 INFO - PID 24428 | |5;imaging-gaussian-blur;115;114;113;114;118;114;114;125;116;114 03:55:09 INFO - PID 24428 | |6;imaging-darkroom;149;151;151;154;153;151;150;152;153;152 03:55:09 INFO - PID 24428 | |7;imaging-desaturate;94;94;97;94;104;95;95;98;99;94 03:55:09 INFO - PID 24428 | |8;json-parse-financial;57;54;53;55;63;56;53;54;54;54 03:55:09 INFO - PID 24428 | |9;json-stringify-tinderbox;59;60;54;55;55;54;57;54;54;54 03:55:09 INFO - PID 24428 | |10;stanford-crypto-aes;81;80;80;79;79;79;79;79;74;77 03:55:09 INFO - PID 24428 | |11;stanford-crypto-ccm;126;121;126;120;127;124;123;124;126;166 03:55:09 INFO - PID 24428 | |12;stanford-crypto-pbkdf2;173;179;175;179;186;177;178;180;178;177 03:55:09 INFO - PID 24428 | |13;stanford-crypto-sha256-iterative;67;76;69;69;66;77;71;70;72;71 03:55:09 INFO - PID 24428 | __end_tp_report 03:55:09 INFO - PID 24428 | __start_cc_report 03:55:09 INFO - PID 24428 | _x_x_mozilla_cycle_collect,967 03:55:09 INFO - PID 24428 | __end_cc_report 03:55:09 INFO - PID 24428 | __startTimestamp1502880909406__endTimestamp 03:55:09 INFO - PID 24428 | 03:55:09 INFO - PID 24428 | ------- Summary: start ------- 03:55:09 INFO - PID 24428 | Number of tests: 14 03:55:09 INFO - PID 24428 | 03:55:09 INFO - PID 24428 | [#0] ai-astar Cycles:10 Average:106.10 Median:109.00 stddev:4.36 (4.0%) stddev-sans-first:3.50 03:55:09 INFO - PID 24428 | Values: 98.0 109.0 103.0 109.0 107.0 107.0 107.0 100.0 110.0 111.0 03:55:09 INFO - PID 24428 | 03:55:09 INFO - PID 24428 | [#1] audio-beat-detection Cycles:10 Average:142.10 Median:147.00 stddev:22.33 (15.2%) stddev-sans-first:23.19 03:55:09 INFO - PID 24428 | Values: 155.0 117.0 139.0 178.0 117.0 153.0 141.0 128.0 173.0 120.0 03:55:09 INFO - PID 24428 | 03:55:09 INFO - PID 24428 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.00 stddev:1.90 (1.2%) stddev-sans-first:2.00 03:55:09 INFO - PID 24428 | Values: 163.0 162.0 163.0 168.0 162.0 162.0 163.0 165.0 165.0 163.0 03:55:09 INFO - PID 24428 | 03:55:09 INFO - PID 24428 | [#3] audio-fft Cycles:10 Average:96.60 Median:76.50 stddev:37.46 (49.0%) stddev-sans-first:38.98 03:55:09 INFO - PID 24428 | Values: 76.0 75.0 78.0 175.0 93.0 76.0 75.0 77.0 158.0 83.0 03:55:09 INFO - PID 24428 | 03:55:09 INFO - PID 24428 | [#4] audio-oscillator Cycles:10 Average:97.60 Median:82.50 stddev:23.90 (29.0%) stddev-sans-first:24.38 03:55:09 INFO - PID 24428 | Values: 79.0 86.0 129.0 83.0 82.0 85.0 133.0 86.0 79.0 134.0 03:55:09 INFO - PID 24428 | 03:55:09 INFO - PID 24428 | [#5] imaging-gaussian-blur Cycles:10 Average:115.70 Median:114.50 stddev:3.56 (3.1%) stddev-sans-first:3.77 03:55:09 INFO - PID 24428 | Values: 115.0 114.0 113.0 114.0 118.0 114.0 114.0 125.0 116.0 114.0 03:55:09 INFO - PID 24428 | 03:55:09 INFO - PID 24428 | [#6] imaging-darkroom Cycles:10 Average:151.60 Median:152.00 stddev:1.51 (1.0%) stddev-sans-first:1.27 03:55:09 INFO - PID 24428 | Values: 149.0 151.0 151.0 154.0 153.0 151.0 150.0 152.0 153.0 152.0 03:55:09 INFO - PID 24428 | 03:55:09 INFO - PID 24428 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:95.00 stddev:3.24 (3.4%) stddev-sans-first:3.32 03:55:09 INFO - PID 24428 | Values: 94.0 94.0 97.0 94.0 104.0 95.0 95.0 98.0 99.0 94.0 03:55:09 INFO - PID 24428 | 03:55:09 INFO - PID 24428 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:54.50 stddev:2.98 (5.5%) stddev-sans-first:3.10 03:55:09 INFO - PID 24428 | Values: 57.0 54.0 53.0 55.0 63.0 56.0 53.0 54.0 54.0 54.0 03:55:09 INFO - PID 24428 | 03:55:09 INFO - PID 24428 | [#9] json-stringify-tinderbox Cycles:10 Average:55.60 Median:55.00 stddev:2.27 (4.1%) stddev-sans-first:2.05 03:55:09 INFO - PID 24428 | Values: 59.0 60.0 54.0 55.0 55.0 54.0 57.0 54.0 54.0 54.0 03:55:09 INFO - PID 24428 | 03:55:09 INFO - PID 24428 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:79.00 stddev:1.95 (2.5%) stddev-sans-first:1.88 03:55:09 INFO - PID 24428 | Values: 81.0 80.0 80.0 79.0 79.0 79.0 79.0 79.0 74.0 77.0 03:55:09 INFO - PID 24428 | 03:55:09 INFO - PID 24428 | [#11] stanford-crypto-ccm Cycles:10 Average:128.30 Median:126.00 stddev:13.44 (10.7%) stddev-sans-first:14.23 03:55:09 INFO - PID 24428 | Values: 126.0 121.0 126.0 120.0 127.0 124.0 123.0 124.0 126.0 166.0 03:55:09 INFO - PID 24428 | 03:55:09 INFO - PID 24428 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.20 Median:178.50 stddev:3.43 (1.9%) stddev-sans-first:3.07 03:55:09 INFO - PID 24428 | Values: 173.0 179.0 175.0 179.0 186.0 177.0 178.0 180.0 178.0 177.0 03:55:09 INFO - PID 24428 | 03:55:09 INFO - PID 24428 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:71.00 stddev:3.52 (5.0%) stddev-sans-first:3.46 03:55:09 INFO - PID 24428 | Values: 67.0 76.0 69.0 69.0 66.0 77.0 71.0 70.0 72.0 71.0 03:55:09 INFO - PID 24428 | -------- Summary: end -------- 03:55:09 INFO - PID 24428 | 03:55:09 INFO - PID 24428 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:55:10 INFO - TEST-INFO | 24428: exit 0 03:55:10 INFO - TEST-OK | kraken | took 62834ms 03:55:10 INFO - SUITE-END | took 1175s 03:55:10 INFO - Completed test suite (00:19:35) 03:55:10 INFO - javascript benchmark 03:55:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8590.251520364769, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3152.464081106212, 3188.713015828575, 3194.728448081913, 3216.195951012246, 3225.8387080645975, 6004.939950600493, 6064.302605200403, 6074.969625151868, 6079.696015199239, 6105.877882442354, 6074.878502429949, 6094.17728606638, 6103.359147289537, 6113.23584551931, 6113.938860611393, 5596.748146333425, 5613.466720661551, 5616.466435688603, 5643.492085712285, 5738.31140263169, 5718.71406429679, 5770.596058275923, 5790.971045144768, 5814.24414826072, 5820.447057529528, 5648.406917273689, 5731.254936858202, 5740.971295143498, 5799.217105690741, 5821.825345239649, 5544.695041772701, 5560.388357280696, 5630.8029218977545, 5674.914876276859, 5701.6864072476, 5567.3040869891265, 5706.4864162225595, 5706.800261990852, 5710.77156913723, 5721.427857214287, 6131.846703832395, 6132.0, 6173.135760993465, 6222.253329600431, 6251.99968005117, 6648.601083934979, 6680.966595167041, 6701.3968742812895, 6721.193456785169, 6724.226713927912, 6701.564398314094, 6745.08941292929, 6765.661716914184, 6768.424683901874, 6773.864522709568, 6174.413430724074, 6194.4425001749605, 6265.0, 6277.18396608438, 6281.309056003836, 6694.899576506356, 6811.931880681229, 6848.075509806113, 6919.065926099912, 6922.2731613180895, 6470.320616335217, 6470.45001174896, 6472.676366181766, 6476.805695829133, 6477.514186436036, 6520.804375868732, 6535.934640653628, 6545.345465453416, 6551.639659818756, 6563.704633291513, 6660.533762636569, 6685.6322902240845, 6690.364415380531, 6696.732130714814, 6710.127683401127, 6672.499562532829, 6732.831679208059, 6735.730570777212, 6743.9325606743305, 6756.4932630052945, 5473.8357849264585, 5474.315710536183, 5532.917006244909, 5549.306336707911, 5560.110382338807, 4512.390827238347, 4563.771811409416, 4622.237330840441, 4671.135839869635, 4692.718436893797, 5808.3901190375245, 5831.2127862738835, 5834.27071616048, 5841.591088623755, 5854.034084376115, 6698.933010669928, 6707.027481015225, 6764.763233286812, 6795.490338224653, 6797.66011699423, 5799.420057994167, 5836.708164591753, 5868.295804503401, 5875.148103524965, 5913.46778789911, 5841.065429531254, 5866.384029676822, 5911.970440147772, 5915.349311575723, 5996.850078748066, 6444.968804991179, 6465.0, 6482.837929051717, 6487.124238227779, 6497.545171837926, 6501.2198536175965, 6583.572067815577, 6589.769358072444, 6600.174978127734, 6618.139641846529, 6418.19772528434, 6422.614643121427, 6463.547551671338, 6483.546151769331, 6567.540272181092, 6307.558470906993, 6541.051547525677, 6561.114249576246, 6644.60132392058, 6646.966765166143, 6527.477801775752, 6617.900731489128, 6694.866102678016, 6794.66026698673, 6795.28649491816, 6343.714532846126, 6353.841153971003, 6354.4281014708895, 6410.358964103739, 6416.582922110048, 6389.361063893573, 6390.169277993831, 6417.903731443938, 6420.454261387835, 6434.0, 5618.831435056954, 6163.260408750979, 6344.1118243445035, 6353.428191462791, 6520.576162549419, 6543.247526534319, 6565.146530950946, 6600.867982640416, 6652.966735166293, 6661.367170118831, 6188.102725104744, 6270.498360131087, 6272.5922815016875, 6330.49356051524, 6442.677866106582], "value": 6072.626796793597, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [777.6539439949225, 806.491910096639, 820.7086484298073, 841.3689732700473, 852.318145483613, 39671.80164099179, 40111.39832902509, 40363.596364036384, 40385.1922961541, 40412.39381409274, 36823.4476482853, 36982.70560530382, 37283.4407483888, 37287.62712372875, 37358.0, 6595.175603049631, 6702.698378572952, 6704.229013663442, 6704.363085506869, 6705.865882682343, 6594.4065034146915, 6671.199456065279, 6677.5325727199115, 6677.899831502531, 6678.966605166992, 7421.554706717588, 7585.241475852398, 7591.582462964535, 7605.733799317025, 7610.505317154395, 7503.024606801108, 7546.584937828417, 7552.169261381244, 7553.999999999973, 7555.508891922007, 7294.781156565258, 7355.705771769123, 7445.739399121005, 7447.813804654873, 7464.589447580381, 37471.43792843109, 37716.24567508662, 37771.24457510834, 37903.62096379029, 37904.620953790385, 3538.7345949053665, 3577.4454959481322, 3580.3018411409785, 3590.5152804371596, 3594.6405359464106, 30758.23104422385, 30802.69197308043, 30952.380952381052, 30959.69040309613, 31110.222244443845, 4706.788194531255, 4712.3167140764735, 4720.0559888022535, 4732.550407711262, 4735.408073990751, 185074.0, 189505.0, 192400.0, 192455.0, 207645.0, 48784.26823597649, 48805.0, 48906.0, 49088.26367604489, 49427.50572494301, 51420.0, 51528.22707659388, 51605.45183644497, 51613.483865161616, 51628.22557661638, 16310.347586096423, 16386.0, 16425.507234782977, 16434.342626294816, 16559.91720041392, 13613.52352667652, 13619.659508512366, 13630.659233519242, 13631.522896698767, 13646.658833529043, 14126.0, 14215.147091174562, 14243.145411275356, 14249.287535623178, 14338.56984290452, 5796.594238403356, 5803.622764520293, 5927.881442371215, 5938.109283607493, 5972.25346831646, 981.4209616326401, 990.4503000834605, 1002.8395456727035, 1005.7737009173023, 1014.5535964175739, 22557.66163507549, 22579.322620321418, 22732.772672273397, 22746.0, 22798.31605051851, 1084.4631907205826, 1084.4957094950885, 1092.5192915117323, 1093.4150229627112, 1106.1095817866533, 12137.514499419924, 12502.249865008129, 12514.18657787241, 12567.811482827765, 12580.748385032248, 244019.0, 245634.0, 245732.0, 246029.0, 246223.0, 51561.0, 51804.48195518072, 52033.21950170751, 52200.477995220324, 52325.2151217732, 1451.8185226846645, 1465.479754687092, 1510.7280689476, 1513.4248985385484, 1517.9089254644757, 22641.660375094056, 22781.658275125556, 22832.543349133255, 22944.196953106562, 23114.422139446648, 35770.10574735652, 35832.28335433225, 35850.64149358473, 35868.820655896554, 35925.64074359328, 195412.0, 198831.0, 199321.0, 199368.0, 199535.0, 33585.496217557244, 35508.82245588859, 37453.62546374501, 37469.81265093657, 37534.06164845901, 46538.534614654774, 46920.29619555778, 47314.29028564643, 47492.0, 47712.5228747722, 34523.30953380968, 34711.305773883876, 34735.0, 34862.30275394529, 35036.474452882714, 33591.66408335983, 33681.494777578846, 33843.3231335367, 33944.3211135771, 34258.48612270868, 37537.0, 37600.81199593985, 37844.810775947044, 37958.62041379551, 38048.048798780255, 32535.349293013533, 32618.51072233966, 32628.184295392806, 32653.673463265062, 32770.67229327676, 24354.081326806016, 24693.382665433506, 24812.131575394775, 25043.12349067774, 25097.498050039263], "value": 17103.363529716557, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.9776808927643, 568.4912003756638, 569.5557465177163, 572.6678526454657, 582.8309790160854, 21903.0, 22532.0, 22684.319470415874, 22696.65955010672, 22718.091276348947, 26670.866645666745, 27452.313692157706, 27551.0, 27576.862115689444, 27583.724162758368, 6439.549231553793, 6587.275399706053, 6592.110065141216, 6594.8681026379445, 6601.339866013408, 6400.487960963112, 6471.5146364022885, 6971.7559885404025, 7021.9297807021785, 7023.051887995106, 6989.860202795941, 7026.754063607775, 7036.7185312587435, 7040.6831692573705, 7048.154221493428, 7044.753433629824, 7049.118860142482, 7051.92948070523, 7054.541454805421, 7056.823579410505, 6892.827679308058, 6917.792466226021, 6918.342757438086, 6922.7923162305215, 6942.201646810631, 31187.532187017212, 31929.52105718416, 32529.837350813094, 32827.50758738621, 32838.0, 1952.8828270303827, 1973.0430741090559, 1978.238378224394, 1985.6922177062434, 1987.076009655517, 19687.0, 20292.0, 20316.492087697778, 20496.5900681987, 20510.38468845922, 2487.4030232744194, 2494.625806129095, 2521.962170567443, 2588.7022992355933, 2602.778763805079, 135561.32219338938, 139463.0, 139534.0, 139558.30220848933, 139936.30031849776, 21246.78753212479, 22393.44016399603, 22820.0, 22867.428314292276, 22953.7704622955, 22998.42503937415, 24215.636765448533, 24259.0, 24304.878475607507, 44626.55373446224, 10104.242181836391, 10257.38455692646, 10326.638567650247, 10414.823478838875, 10444.268901176996, 9397.436153830791, 9458.95270523643, 9471.431714097176, 9512.429254244767, 9540.904590954002, 9696.224302055818, 9798.363106398061, 9848.06443387877, 9938.801223975624, 10011.199104071657, 2788.288986308519, 2805.116388337708, 2833.461642288, 2882.1497658190883, 2890.59531665567, 955.6846240740539, 976.72651657536, 978.7846673731767, 982.4203719805349, 992.34009383759, 19613.41159765209, 19898.801011989985, 20097.799022009884, 20130.798692012893, 20310.49223769388, 1036.533559898049, 1043.9739006524746, 1046.6075221791828, 1049.4490392543823, 1050.5167622893555, 11196.832047519294, 11243.60647377338, 11254.493547790205, 11334.943325283486, 11365.488553015135, 468590.0, 471323.0, 478117.0, 481232.0, 482131.0, 115876.42061789805, 117081.4145929282, 118148.0, 118496.40751796185, 118681.0, 1176.5940750441084, 1188.3464094747853, 1213.0416970593133, 1214.817777333407, 1225.4485481533168, 17224.224909878834, 17444.47666570005, 17587.472375828747, 17589.82410175882, 17977.73033404474, 57152.142717858434, 57658.7117064412, 58029.709851450476, 59509.40490595212, 62324.688376557824, 68217.65891170711, 68689.0, 68731.31268687449, 68746.0, 69233.0, 14648.414063437343, 15089.698206036037, 15142.54572362831, 15196.088234705952, 15196.468123615621, 23698.170564030177, 23720.169794057125, 23913.282601521983, 24027.27918162458, 24071.398215044763, 18659.60052996058, 19550.413487595393, 19587.314443994394, 19611.411657650293, 19849.0, 17299.13504324804, 17467.03931283741, 17708.822911771233, 17737.201825918124, 18458.907705461923, 19683.507912302306, 19918.0, 20271.59456810826, 20389.082491288224, 20446.693299600814, 14583.125012499284, 14881.25593720288, 15195.164265965035, 15221.771673424686, 15252.847471525143, 19412.70880936759, 19580.11889465006, 19618.313359032367, 19711.310104146287, 19716.309929152412], "value": 12538.478460608534, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1383.5157694806817, 1439.460202424091, 1445.9710805783889, 1450.4778279819257, 1451.027811366385, 14217.92891035546, 14225.715485690293, 14806.703865922702, 14856.92571537142, 14857.40570377185, 14989.550313490612, 15231.771523427129, 15236.466723664675, 15242.695146097072, 15262.236888155576, 2530.5192013517417, 2572.9228123156336, 2573.0, 2576.716561178269, 2582.018832843517, 2676.611891275764, 2692.569188929772, 2730.194592595179, 2730.84980326083, 2731.4537092581563, 2677.4377380750066, 2701.594760785888, 2711.376383431812, 2727.059164588214, 2727.8772455239464, 2633.9341516462146, 2640.471905618874, 2651.893924243028, 2651.9867400662874, 2658.8537630430415, 2578.2909699832508, 2589.766920977121, 2602.4795040991876, 2611.7127116017223, 2612.3207965928805, 14134.15195088298, 14222.146671199762, 14346.42614295427, 14350.0, 14363.784543231859, 7445.8510829783645, 7456.440766942501, 7705.190954949761, 7711.652975616111, 7754.689812407497, 4869.196582563908, 5055.545000949895, 5161.845144645667, 5172.560332371753, 5188.22176673502, 1887.282832523646, 1892.8674992750514, 1902.7431296774896, 1937.3509874192162, 1947.8928658923753, 22977.65533516982, 23109.653355199687, 23167.652485212737, 23348.533029339316, 23918.760812392, 6318.431341179224, 6320.589161704566, 6547.476201903836, 6573.1783527059115, 6580.045893345534, 16530.0908450034, 16539.090350030863, 16581.91709041447, 16600.916995414944, 16606.584835379213, 7606.847863042708, 7717.768466946, 7733.690652373954, 7751.418643601753, 7760.883586746203, 5567.4432556744005, 5976.880462390728, 6070.0591408331775, 6080.9391906081255, 7130.572165670076, 4924.3105965164905, 5049.697018178847, 5133.974330128325, 5146.562542183881, 5166.689998600096, 1477.6453651123652, 1480.7704805755125, 1491.2990894279671, 1493.5444689369847, 1514.5834895403852, 878.2578720980761, 900.7883147460342, 906.2930913887178, 910.5128756115579, 915.6428992692855, 7058.588581841743, 7212.423006159494, 7224.819379515554, 7273.908913662993, 7375.44684148691, 690.4614400767409, 702.455596912397, 703.6763088979127, 710.9715611375591, 716.3624374306871, 4446.110777844444, 4458.108378324348, 4463.419755431773, 4535.705179163344, 5131.589472842238, 19787.20851165966, 20286.69569956452, 20364.49088772763, 20870.37388878336, 20976.895115524323, 20347.8982605089, 20470.488237794176, 20540.07569659369, 20715.58568828645, 20755.481112972295, 10695.679129626124, 11093.0, 11094.278871873303, 11251.381174035343, 11274.041706455044, 7721.150673425806, 8063.072746634212, 8230.588470576567, 8358.958205208935, 8406.075331713384, 16325.183740813149, 16516.0, 16544.917275413547, 16557.91721041387, 17003.91498042502, 17648.294068237126, 17766.733498997266, 17933.820661793216, 18001.549961251072, 18032.278708852024, 11644.88355116472, 11787.587434439753, 11882.10884183707, 11892.0, 11892.762144756884, 13421.194728316332, 13437.596872093853, 13557.118787278796, 13582.728345432839, 13663.521776737767, 10959.0, 10990.08469633421, 11030.28303160292, 11212.15908806859, 11408.71478213018, 11133.55465781392, 11141.72145696364, 11185.32888026721, 11274.0, 11408.315501069963, 9393.577289021874, 9475.952620236854, 9584.089511496397, 9603.807923841623, 9607.711768646952, 7140.821479463055, 7160.534565253241, 7174.713011479483, 7193.100862392201, 7232.602206878672, 6843.555168914005, 6849.691763870737, 7010.900516550633, 7042.859142817012, 7078.787636370917], "value": 6371.8547172398785, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [486.82040108329346, 495.7594334741107, 516.6409345504874, 517.5781737883627, 519.6803965561179, 6069.9999999999945, 6220.502359811216, 6243.500519958404, 6248.9062664060075, 6258.780942667007, 5814.296352196228, 6069.150318955339, 6105.664188469633, 6137.26352837659, 6146.8463288417815, 4975.278584605248, 4975.3283306753665, 4976.328195693589, 4989.675671081377, 5016.974915125419, 4975.437649610453, 4977.850664480054, 5000.874978125539, 5038.622103342264, 5041.1178043842365, 4774.450938142123, 4927.433345165298, 4932.432770231416, 4941.827036053739, 4945.18404463265, 4931.309616653672, 4938.950610493903, 4966.081274964144, 5002.59979201663, 5031.597472202215, 4449.221386257392, 4452.48796388413, 4454.621357184643, 4467.352233926063, 4473.4408198975125, 6045.72794224261, 6047.7278522466595, 6055.698024924663, 6069.908951365733, 6082.300535438437, 5668.263125793662, 5676.403977582336, 5689.0, 5734.369219385864, 5760.423957604206, 6337.2395312562785, 6442.581232219891, 6498.187726534184, 6519.478441724698, 6580.901286480706, 4841.878953026203, 4858.514148585114, 4898.608111351084, 4899.1426500362295, 4904.852854414374, 6878.621675807829, 6928.896066558956, 6945.89581156283, 6963.8607227855155, 6985.882258838561, 4953.578945789576, 4971.65198436106, 5002.52476014778, 5007.674501157413, 5041.974790126026, 5007.499250075036, 5030.723310217973, 5032.936496036607, 5044.899102017939, 5053.67151135175, 5692.7722891083895, 5705.2012718219485, 5712.857178570569, 5732.742026608813, 5758.481736643638, 6471.449926756279, 6491.799017181742, 6535.901961470582, 6567.737290508422, 6574.408303252731, 1666.5833541614597, 1688.729803231477, 1698.8131305556378, 1729.4725108841671, 1765.8521960725375, 1198.7063169523349, 1215.6353094071744, 1229.9631011069682, 1233.9321337326353, 1236.116176933497, 5684.545236381162, 5720.542356611461, 5739.225204597409, 5799.39106393831, 5819.970900145472, 6577.210734711865, 6595.934040659532, 6597.835054123685, 6636.668166591651, 6645.900311495331, 5759.740811663485, 5786.566007549451, 5831.358550559435, 5869.735861886225, 5877.23595932526, 3532.7350448716447, 3545.4681797730545, 3555.6888022785397, 3583.3012562550575, 3606.124815096188, 6606.504512161511, 6628.304028077079, 6648.966755166193, 6674.666266686646, 6688.531802773759, 6890.31096890307, 6947.79156625302, 7009.228984811667, 7027.016217729522, 7039.54242974205, 6507.3731567108225, 6515.315891831384, 6641.402273795382, 6643.867122657616, 6680.298568650222, 6716.1940567130305, 6755.459563235027, 6791.626460544718, 6818.454523638196, 6823.847994763922, 6592.472602191909, 6611.033379971978, 6721.529492935448, 6743.460523158234, 6750.426213771884, 6531.216254049545, 6564.704588293443, 6596.90104648421, 6651.46788256948, 6662.666866656745, 4951.10880041596, 4951.77717002743, 4967.130752118293, 4968.801247950041, 4974.452810190948, 6712.83217919556, 6738.7304507819135, 6756.155480564929, 6766.729330826712, 6769.796906092825, 6359.872802544016, 6429.292777794532, 6532.706028228836, 6552.6068435894, 6554.868902621825, 6436.549441539048, 6489.902651460137, 6543.476521878333, 6558.278589355072, 6577.408033277028, 6238.344973777688, 6270.181647322408, 6396.456301214449, 6399.520035997226, 6474.838129046623, 6546.639934803441, 6546.803595892131, 6589.967050164719, 6603.80188594343, 6623.2383275923885, 6328.082428047999, 6332.30344662096, 6373.904391434225, 6395.6802159890885, 6398.168238129014], "value": 5051.89076308698, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [913.2876356441977, 925.1165137293884, 929.8791157149569, 933.6778811310099, 957.105106725212, 18836.152373143206, 19788.60422791545, 19950.401487955383, 19967.10148043338, 23015.19446819362, 20461.590768184626, 21996.230131945384, 22541.774582254173, 22543.661845072296, 22546.43633909153, 1041.9739506512342, 1065.0, 1072.0137473524376, 1072.1744256922166, 1072.9409882456462, 1073.0771536478621, 1075.5428942699361, 1076.4994277660885, 1076.8169411200115, 1077.1006209814775, 1124.3872089711126, 1127.4193790198055, 1127.9379634120162, 1129.0177545535396, 1129.3844854554247, 1131.1120770195357, 1132.898039176474, 1133.6882357351753, 1133.7222380516744, 1134.5915470430639, 821.1337039423406, 822.1244374740942, 822.2763967708378, 823.3454403749034, 823.555280148719, 20370.0, 20681.89659051695, 20771.68842467364, 20843.16627334905, 20862.687059694115, 21878.12487500498, 21985.890070549704, 22359.552808943892, 22435.663465048037, 22445.775542244533, 16660.6667866642, 16941.40705075329, 17100.657986840317, 17182.48452546413, 17195.054272015033, 3656.3784156693428, 3693.4829123922673, 3695.4087346024776, 3701.0747313171705, 3702.5742039665515, 128380.0, 129523.99999999905, 130180.0, 131038.0, 132214.0, 16796.664066718597, 16828.326866925185, 17218.827811721974, 17220.65558688819, 17232.396866109877, 30798.84600576983, 31134.0, 31252.37495250128, 31319.843400783306, 31351.216219594236, 7618.276263754934, 8737.563121843883, 8898.4660920345, 9145.81708365829, 9235.953820230856, 4300.526942036374, 4369.366441865912, 4378.277584198635, 4383.9342409863875, 4385.758783266887, 5324.094903866352, 5413.377461591967, 5434.130539113802, 5798.130280457881, 5987.64074155552, 1063.5852017713098, 1088.755030118217, 1096.9177311701653, 1100.1968562948932, 1105.0772604874858, 675.2707076357522, 685.7428464325877, 691.7302252121676, 695.2664938489942, 706.4948561778353, 12315.876841231653, 12423.875761242272, 12533.874661253452, 13296.468141274241, 13330.466781328832, 670.085333519742, 674.6087269383746, 675.4663815585633, 676.6210921883761, 677.6747161362573, 5802.21670074543, 6002.969985150046, 6557.5081868860025, 6564.901526477107, 6649.60102393858, 111721.0, 111938.44030779957, 114732.0, 114767.0, 116282.0, 98017.0, 100118.0, 100305.0, 101027.49486252668, 101699.0, 86924.0, 89254.55372723094, 90951.0, 91804.54097729603, 93257.533712331, 12858.42137103814, 13082.542111026069, 13131.34343282813, 13241.735165296834, 13376.598702038955, 38337.80831095938, 38863.222735544565, 38920.41619375655, 39389.409158862065, 40709.0, 71269.28730712626, 72393.27606723865, 73073.26926730665, 73361.16597085116, 75034.62482687552, 19216.903915480892, 19320.227190912206, 19334.903325483847, 19429.12568934373, 19608.215671372986, 20191.0, 20643.380698579065, 20655.793442065988, 20788.0, 20878.269260575806, 18360.173792179117, 18521.166547505665, 19934.900325498278, 20042.699359509326, 20492.590148196654, 20399.592008159456, 20558.177672892918, 20583.38249852507, 20609.0, 20698.275560355316, 17961.281548737905, 18785.6242875139, 19391.903040484707, 19463.92948387852, 19567.902160489677, 12917.741645167232, 13792.379342929391, 14173.858261417254, 14180.432782688576, 14488.34802433914, 14322.14067155974, 14595.343209555807, 14895.106293622417, 14906.329215185126, 15789.447369342477], "value": 9584.840107476259, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1536.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 109.0, 103.0, 109.0, 107.0, 107.0, 107.0, 100.0, 110.0, 111.0], "value": 106.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 117.0, 139.0, 178.0, 117.0, 153.0, 141.0, 128.0, 173.0, 120.0], "value": 142.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 168.0, 162.0, 162.0, 163.0, 165.0, 165.0, 163.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 78.0, 175.0, 93.0, 76.0, 75.0, 77.0, 158.0, 83.0], "value": 96.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 86.0, 129.0, 83.0, 82.0, 85.0, 133.0, 86.0, 79.0, 134.0], "value": 97.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 113.0, 114.0, 118.0, 114.0, 114.0, 125.0, 116.0, 114.0], "value": 115.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 151.0, 151.0, 154.0, 153.0, 151.0, 150.0, 152.0, 153.0, 152.0], "value": 151.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 97.0, 94.0, 104.0, 95.0, 95.0, 98.0, 99.0, 94.0], "value": 96.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 53.0, 55.0, 63.0, 56.0, 53.0, 54.0, 54.0, 54.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 54.0, 55.0, 55.0, 54.0, 57.0, 54.0, 54.0, 54.0], "value": 55.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 80.0, 79.0, 79.0, 79.0, 79.0, 79.0, 74.0, 77.0], "value": 78.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 121.0, 126.0, 120.0, 127.0, 124.0, 123.0, 124.0, 126.0, 166.0], "value": 128.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 179.0, 175.0, 179.0, 186.0, 177.0, 178.0, 180.0, 178.0, 177.0], "value": 178.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 76.0, 69.0, 69.0, 66.0, 77.0, 71.0, 70.0, 72.0, 71.0], "value": 70.8, "unit": "score"}]}]} 03:55:10 INFO - Return code: 0 03:55:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:55:10 INFO - # TBPL SUCCESS # 03:55:10 INFO - Running post-action listener: _package_coverage_data 03:55:10 INFO - Running post-action listener: _resource_record_post_action 03:55:10 INFO - [mozharness: 2017-08-16 10:55:10.703627Z] Finished run-tests step (success) 03:55:10 INFO - Running post-run listener: _resource_record_post_run 03:55:10 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 0; Write bytes: 433283072; Read time: 0; Write time: 283336 03:55:10 INFO - TinderboxPrint: CPU usage
13.1% 03:55:10 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 03:55:10 INFO - TinderboxPrint: I/O write bytes / time
433,283,072 / 283,336 03:55:10 INFO - TinderboxPrint: CPU idle
8,266.8 (86.8%) 03:55:10 INFO - TinderboxPrint: CPU user
1,203.5 (12.6%) 03:55:10 INFO - TinderboxPrint: Swap in / out
0 / 0 03:55:10 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107520000; Read time: 0; Write time: 80616 03:55:10 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:55:10 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 325763072; Read time: 0; Write time: 202720 03:55:11 INFO - Running post-run listener: _upload_blobber_files 03:55:11 INFO - Blob upload gear active. 03:55:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:55:11 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:55:11 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:55:11 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:55:11 INFO - (blobuploader) - INFO - Open directory for files ... 03:55:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:55:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:55:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:12 INFO - (blobuploader) - INFO - Done attempting. 03:55:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:55:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:55:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:13 INFO - (blobuploader) - INFO - Done attempting. 03:55:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:55:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:14 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:55:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:14 INFO - (blobuploader) - INFO - Done attempting. 03:55:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:55:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:55:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:20 INFO - (blobuploader) - INFO - Done attempting. 03:55:20 INFO - (blobuploader) - INFO - Iteration through files over. 03:55:20 INFO - Return code: 0 03:55:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:55:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:55:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07c29b8f1502f8381a013b7aeeb49a08dcb039f9c3faa0a96a5760dea36d08a5592e65aa90918730181abcd8863f59a6fa563b7c39510e45b4c188652bc89810", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dff30403120445216a419440d3e4a105a3244d9e8b01e03a3b872118ba5259eadbb6abbd83e0d376995952a11b0e6501e6b385d58bdb62ac8f75ec0cc3f70cf6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f88bc2c286dc8269e296f5f57260f43848d12009710744593a8727d9a49f59b7d89bdda4e64df59f8b55441d87793cf9a06d5ebecff81ca7636b00aee71f8846", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c6f525917a30c3eab975c5e35bb6d6046655729e72fd2093d0f182f9803d98629645dd07593491f510907a40f8aa2945ec6cfcbfed1f53f683001c02466df090"} 03:55:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:55:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:55:20 INFO - Contents: 03:55:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07c29b8f1502f8381a013b7aeeb49a08dcb039f9c3faa0a96a5760dea36d08a5592e65aa90918730181abcd8863f59a6fa563b7c39510e45b4c188652bc89810", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dff30403120445216a419440d3e4a105a3244d9e8b01e03a3b872118ba5259eadbb6abbd83e0d376995952a11b0e6501e6b385d58bdb62ac8f75ec0cc3f70cf6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f88bc2c286dc8269e296f5f57260f43848d12009710744593a8727d9a49f59b7d89bdda4e64df59f8b55441d87793cf9a06d5ebecff81ca7636b00aee71f8846", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c6f525917a30c3eab975c5e35bb6d6046655729e72fd2093d0f182f9803d98629645dd07593491f510907a40f8aa2945ec6cfcbfed1f53f683001c02466df090"} 03:55:20 INFO - Running post-run listener: copy_logs_to_upload_dir 03:55:20 INFO - Copying logs to upload dir... 03:55:20 INFO - mkdir: /builds/slave/test/build/upload/logs 03:55:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.229450 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-16 03:55:20.362238) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-16 03:55:20.370044) ========= 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=db7e7c15f3ca076d53731445000001ba-1502879662.959386-1115570645 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/07c29b8f1502f8381a013b7aeeb49a08dcb039f9c3faa0a96a5760dea36d08a5592e65aa90918730181abcd8863f59a6fa563b7c39510e45b4c188652bc89810", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dff30403120445216a419440d3e4a105a3244d9e8b01e03a3b872118ba5259eadbb6abbd83e0d376995952a11b0e6501e6b385d58bdb62ac8f75ec0cc3f70cf6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f88bc2c286dc8269e296f5f57260f43848d12009710744593a8727d9a49f59b7d89bdda4e64df59f8b55441d87793cf9a06d5ebecff81ca7636b00aee71f8846", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c6f525917a30c3eab975c5e35bb6d6046655729e72fd2093d0f182f9803d98629645dd07593491f510907a40f8aa2945ec6cfcbfed1f53f683001c02466df090"} build_url:https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011289 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/07c29b8f1502f8381a013b7aeeb49a08dcb039f9c3faa0a96a5760dea36d08a5592e65aa90918730181abcd8863f59a6fa563b7c39510e45b4c188652bc89810", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dff30403120445216a419440d3e4a105a3244d9e8b01e03a3b872118ba5259eadbb6abbd83e0d376995952a11b0e6501e6b385d58bdb62ac8f75ec0cc3f70cf6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f88bc2c286dc8269e296f5f57260f43848d12009710744593a8727d9a49f59b7d89bdda4e64df59f8b55441d87793cf9a06d5ebecff81ca7636b00aee71f8846", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c6f525917a30c3eab975c5e35bb6d6046655729e72fd2093d0f182f9803d98629645dd07593491f510907a40f8aa2945ec6cfcbfed1f53f683001c02466df090"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-16 03:55:20.399687) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:55:20.400034) ========= 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=db7e7c15f3ca076d53731445000001ba-1502879662.959386-1115570645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004551 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:55:20.480530) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-16 03:55:20.483867) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-16 03:55:20.484168) ========= ========= Total master_lag: 0.18 =========