builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-082 starttime: 1500725666.99 results: success (0) revision: 7ce557b85b611536b69539a7c18d4834ffc92eea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-22 05:14:26.989824) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-22 05:14:26.990250) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-22 05:14:26.990523) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-22 05:14:27.039581) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 05:14:27.039854) ========= 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=51fc86400edbde9650d2781a000001d0-1500724630.712852-635091411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-22 05:14:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 227M=0s 2017-07-22 05:14:28 (227 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.121125 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 05:14:27.183753) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 05:14:27.184042) ========= 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=51fc86400edbde9650d2781a000001d0-1500724630.712852-635091411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016610 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 05:14:27.237471) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-22 05:14:27.237755) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7ce557b85b611536b69539a7c18d4834ffc92eea --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 7ce557b85b611536b69539a7c18d4834ffc92eea --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=51fc86400edbde9650d2781a000001d0-1500724630.712852-635091411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-22 05:14:28,195 truncating revision to first 12 chars 2017-07-22 05:14:28,195 Setting DEBUG logging. 2017-07-22 05:14:28,195 attempt 1/10 2017-07-22 05:14:28,195 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7ce557b85b61?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-22 05:14:29,173 unpacking tar archive at: mozilla-central-7ce557b85b61/testing/mozharness/ program finished with exit code 0 elapsedTime=1.382882 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-22 05:14:28.639172) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-22 05:14:28.639474) ========= script_repo_revision: 7ce557b85b611536b69539a7c18d4834ffc92eea ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-22 05:14:28.639844) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-22 05:14:28.640118) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-22 05:14:28.649781) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2017-07-22 05:14:28.650071) ========= /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=51fc86400edbde9650d2781a000001d0-1500724630.712852-635091411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:14:29 INFO - MultiFileLogger online at 20170722 05:14:29 in /builds/slave/test 05:14:29 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 05:14:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:14:29 INFO - {'append_to_log': False, 05:14:29 INFO - 'base_work_dir': '/builds/slave/test', 05:14:29 INFO - 'blob_upload_branch': 'Firefox', 05:14:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:14:29 INFO - 'branch': 'Firefox', 05:14:29 INFO - 'buildbot_json_path': 'buildprops.json', 05:14:29 INFO - 'code_coverage': False, 05:14:29 INFO - 'config_files': ('talos/linux_config.py',), 05:14:29 INFO - 'default_actions': ('clobber', 05:14:29 INFO - 'read-buildbot-config', 05:14:29 INFO - 'download-and-extract', 05:14:29 INFO - 'populate-webroot', 05:14:29 INFO - 'create-virtualenv', 05:14:29 INFO - 'install', 05:14:29 INFO - 'setup-mitmproxy', 05:14:29 INFO - 'run-tests'), 05:14:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:14:29 INFO - 'disable_ccov_upload': False, 05:14:29 INFO - 'download_minidump_stackwalk': True, 05:14:29 INFO - 'download_symbols': 'ondemand', 05:14:29 INFO - 'enable_stylo': False, 05:14:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:14:29 INFO - 'tooltool.py': '/tools/tooltool.py', 05:14:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:14:29 INFO - '/tools/misc-python/virtualenv.py')}, 05:14:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:14:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:14:29 INFO - 'gecko_profile': False, 05:14:29 INFO - 'gecko_profile_interval': 0, 05:14:29 INFO - 'installer_path': 'installer.exe', 05:14:29 INFO - 'log_level': 'info', 05:14:29 INFO - 'log_name': 'talos', 05:14:29 INFO - 'log_to_console': True, 05:14:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:14:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:14:29 INFO - 'opt_config_files': (), 05:14:29 INFO - 'pip_index': False, 05:14:29 INFO - 'suite': 'dromaeojs-e10s', 05:14:29 INFO - 'system_bits': '32', 05:14:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:14:29 INFO - 'title': 'talos-linux64-ix-082', 05:14:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:14:29 INFO - 'use_talos_json': True, 05:14:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:14:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:14:29 INFO - 'work_dir': 'build'} 05:14:29 INFO - [mozharness: 2017-07-22 12:14:29.705620Z] Running clobber step. 05:14:29 INFO - Running pre-action listener: _resource_record_pre_action 05:14:29 INFO - Running main action method: clobber 05:14:29 INFO - rmtree: /builds/slave/test/build 05:14:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:14:30 INFO - Running post-action listener: _resource_record_post_action 05:14:30 INFO - [mozharness: 2017-07-22 12:14:30.750106Z] Finished clobber step (success) 05:14:30 INFO - [mozharness: 2017-07-22 12:14:30.750208Z] Running read-buildbot-config step. 05:14:30 INFO - Running pre-action listener: _resource_record_pre_action 05:14:30 INFO - Running main action method: read_buildbot_config 05:14:30 INFO - Using buildbot properties: 05:14:30 INFO - { 05:14:30 INFO - "project": "", 05:14:30 INFO - "product": "firefox", 05:14:30 INFO - "who": "archaeopteryx@coole-files.de", 05:14:30 INFO - "installer_path": "public/build/target.tar.bz2", 05:14:30 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:14:30 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 05:14:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:14:30 INFO - "stage_platform": "linux64-pgo", 05:14:30 INFO - "basedir": "/builds/slave/test", 05:14:30 INFO - "buildnumber": 79, 05:14:30 INFO - "platform": "ubuntu64_hw", 05:14:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:14:30 INFO - "slavebuilddir": "test", 05:14:30 INFO - "taskId": "DZ2uDSQaRqKkmiOIE6BIsQ", 05:14:30 INFO - "branch": "mozilla-central", 05:14:30 INFO - "script_repo_revision": "production", 05:14:30 INFO - "revision": "7ce557b85b611536b69539a7c18d4834ffc92eea", 05:14:30 INFO - "slavename": "talos-linux64-ix-082", 05:14:30 INFO - "repo_path": "mozilla-central" 05:14:30 INFO - } 05:14:30 INFO - Finding installer, test and symbols from parent task. 05:14:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DZ2uDSQaRqKkmiOIE6BIsQ'}, attempt #1 05:14:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DZ2uDSQaRqKkmiOIE6BIsQ'}, attempt #1 05:14:31 INFO - Task dependencies: XJOKhumSTkeEvXj_ZHnCCQ 05:14:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XJOKhumSTkeEvXj_ZHnCCQ'}, attempt #1 05:14:32 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/XJOKhumSTkeEvXj_ZHnCCQ/artifacts/public/build/target.tar.bz2 05:14:32 INFO - Set test_url: https://queue.taskcluster.net/v1/task/XJOKhumSTkeEvXj_ZHnCCQ/artifacts/public/build/test_packages.json 05:14:32 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/XJOKhumSTkeEvXj_ZHnCCQ/artifacts/public/build/target.crashreporter-symbols.zip 05:14:32 INFO - Running post-action listener: _resource_record_post_action 05:14:32 INFO - [mozharness: 2017-07-22 12:14:32.089687Z] Finished read-buildbot-config step (success) 05:14:32 INFO - [mozharness: 2017-07-22 12:14:32.089908Z] Running download-and-extract step. 05:14:32 INFO - Running pre-action listener: _resource_record_pre_action 05:14:32 INFO - Running main action method: download_and_extract 05:14:32 INFO - mkdir: /builds/slave/test/build/tests 05:14:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:32 INFO - trying https://queue.taskcluster.net/v1/task/XJOKhumSTkeEvXj_ZHnCCQ/artifacts/public/build/target.test_packages.json 05:14:32 INFO - Downloading https://queue.taskcluster.net/v1/task/XJOKhumSTkeEvXj_ZHnCCQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:14:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XJOKhumSTkeEvXj_ZHnCCQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:14:32 INFO - Downloaded 989 bytes. 05:14:32 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:14:32 INFO - Using the following test package requirements: 05:14:32 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:14:32 INFO - u'common': [u'target.common.tests.zip'], 05:14:32 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:14:32 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:14:32 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:14:32 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:14:32 INFO - u'mozbase': [u'target.common.tests.zip'], 05:14:32 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:14:32 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:14:32 INFO - u'web-platform': [u'target.common.tests.zip', 05:14:32 INFO - u'target.web-platform.tests.tar.gz'], 05:14:32 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:14:32 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:14:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XJOKhumSTkeEvXj_ZHnCCQ/artifacts/public/build/target.common.tests.zip 05:14:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XJOKhumSTkeEvXj_ZHnCCQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:14:32 INFO - Fetch https://queue.taskcluster.net/v1/task/XJOKhumSTkeEvXj_ZHnCCQ/artifacts/public/build/target.common.tests.zip into memory 05:14:32 INFO - retry: attempt #1 caught HTTPError exception: HTTP Error 500: Internal Server Error 05:14:32 INFO - retry: Failed, sleeping 30 seconds before retrying 05:15:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XJOKhumSTkeEvXj_ZHnCCQ/artifacts/public/build/target.common.tests.zip'}, attempt #2 05:15:03 INFO - Fetch https://queue.taskcluster.net/v1/task/XJOKhumSTkeEvXj_ZHnCCQ/artifacts/public/build/target.common.tests.zip into memory 05:15:04 INFO - Content-Length response header: 73369232 05:15:04 INFO - Bytes received: 73369232 05:15:15 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:15:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XJOKhumSTkeEvXj_ZHnCCQ/artifacts/public/build/target.common.tests.zip 05:15:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XJOKhumSTkeEvXj_ZHnCCQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:15:15 INFO - Fetch https://queue.taskcluster.net/v1/task/XJOKhumSTkeEvXj_ZHnCCQ/artifacts/public/build/target.common.tests.zip into memory 05:15:16 INFO - Content-Length response header: 73369232 05:15:16 INFO - Bytes received: 73369232 05:15:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XJOKhumSTkeEvXj_ZHnCCQ/artifacts/public/build/target.talos.tests.zip 05:15:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XJOKhumSTkeEvXj_ZHnCCQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:15:29 INFO - Fetch https://queue.taskcluster.net/v1/task/XJOKhumSTkeEvXj_ZHnCCQ/artifacts/public/build/target.talos.tests.zip into memory 05:15:29 INFO - Content-Length response header: 14498826 05:15:29 INFO - Bytes received: 14498826 05:15:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:29 INFO - trying https://queue.taskcluster.net/v1/task/XJOKhumSTkeEvXj_ZHnCCQ/artifacts/public/build/target.tar.bz2 05:15:29 INFO - Downloading https://queue.taskcluster.net/v1/task/XJOKhumSTkeEvXj_ZHnCCQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:15:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XJOKhumSTkeEvXj_ZHnCCQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:15:31 INFO - Downloaded 62877004 bytes. 05:15:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XJOKhumSTkeEvXj_ZHnCCQ/artifacts/public/build/target.tar.bz2 05:15:31 INFO - mkdir: /builds/slave/test/properties 05:15:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:15:31 INFO - Writing to file /builds/slave/test/properties/build_url 05:15:31 INFO - Contents: 05:15:31 INFO - build_url:https://queue.taskcluster.net/v1/task/XJOKhumSTkeEvXj_ZHnCCQ/artifacts/public/build/target.tar.bz2 05:15:31 INFO - Running post-action listener: _resource_record_post_action 05:15:31 INFO - Running post-action listener: set_extra_try_arguments 05:15:31 INFO - [mozharness: 2017-07-22 12:15:31.271173Z] Finished download-and-extract step (success) 05:15:31 INFO - [mozharness: 2017-07-22 12:15:31.271270Z] Running populate-webroot step. 05:15:31 INFO - Running pre-action listener: _resource_record_pre_action 05:15:31 INFO - Running main action method: populate_webroot 05:15:31 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:15:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:15:31 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:15:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:15:31 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:15:31 INFO - 'tests': ['damp', 'tps']}, 05:15:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:15:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:15:31 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:15:31 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:15:31 INFO - 'other-e10s': {'tests': ['a11yr', 05:15:31 INFO - 'ts_paint', 05:15:31 INFO - 'tpaint', 05:15:31 INFO - 'sessionrestore', 05:15:31 INFO - 'sessionrestore_many_windows', 05:15:31 INFO - 'sessionrestore_no_auto_restore', 05:15:31 INFO - 'tabpaint']}, 05:15:31 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 05:15:31 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 05:15:31 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:15:31 INFO - 'talos_options': ['--mitmproxy', 05:15:31 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:15:31 INFO - '--firstNonBlankPaint'], 05:15:31 INFO - 'tests': ['quantum_pageload_google', 05:15:31 INFO - 'quantum_pageload_youtube', 05:15:31 INFO - 'quantum_pageload_amazon', 05:15:31 INFO - 'quantum_pageload_facebook']}, 05:15:31 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:15:31 INFO - 'talos_options': ['--stylo', 05:15:31 INFO - '--mitmproxy', 05:15:31 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:15:31 INFO - '--firstNonBlankPaint'], 05:15:31 INFO - 'tests': ['quantum_pageload_google', 05:15:31 INFO - 'quantum_pageload_youtube', 05:15:31 INFO - 'quantum_pageload_amazon', 05:15:31 INFO - 'quantum_pageload_facebook']}, 05:15:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:15:31 INFO - 'tsvgr_opacity', 05:15:31 INFO - 'tart', 05:15:31 INFO - 'tscrollx', 05:15:31 INFO - 'cart', 05:15:31 INFO - 'tsvg_static']}, 05:15:31 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:15:31 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:15:31 INFO - 'talos_options': ['--xperf_path', 05:15:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:15:31 INFO - 'tests': ['tp5n']}}} 05:15:31 INFO - Running post-action listener: _resource_record_post_action 05:15:31 INFO - [mozharness: 2017-07-22 12:15:31.278551Z] Finished populate-webroot step (success) 05:15:31 INFO - [mozharness: 2017-07-22 12:15:31.278640Z] Running create-virtualenv step. 05:15:31 INFO - Running pre-action listener: _resource_record_pre_action 05:15:31 INFO - Running main action method: create_virtualenv 05:15:31 INFO - Creating virtualenv /builds/slave/test/build/venv 05:15:31 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 05:15:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:15:31 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:15:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:15:31 INFO - Using real prefix '/usr' 05:15:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:15:31 INFO - Installing distribute.............................................................................................................................................................................................done. 05:15:33 INFO - Installing pip.................done. 05:15:33 INFO - Return code: 0 05:15:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:15:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:15:34 INFO - Reading from file tmpfile_stdout 05:15:34 INFO - Output received: 05:15:34 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) 05:15:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:15: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')]} 05:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15: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')]} 05:15:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xa561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc22a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc2eb0>, '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 0xdc3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc4240>, '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': '51fc86400edbde9650d2781a000001d0-1500724630.712852-635091411', '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 05:15:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:15:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:15:34 INFO - Using env: {'DISPLAY': ':0', 05:15:34 INFO - 'HOME': '/home/cltbld', 05:15:34 INFO - 'LANG': 'en_US.UTF-8', 05:15:34 INFO - 'LANGUAGE': 'en_US:en', 05:15:34 INFO - 'LOGNAME': 'cltbld', 05:15:34 INFO - 'MAIL': '/var/mail/cltbld', 05:15:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:34 INFO - 'MOZ_NO_REMOTE': '1', 05:15:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:34 INFO - 'NO_EM_RESTART': '1', 05:15:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:34 INFO - 'PWD': '/builds/slave/test', 05:15:34 INFO - 'SHELL': '/bin/bash', 05:15:34 INFO - 'SHLVL': '1', 05:15:34 INFO - 'TERM': 'linux', 05:15:34 INFO - 'TMOUT': '86400', 05:15:34 INFO - 'USER': 'cltbld', 05:15:34 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1500724630.712852-635091411', 05:15:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:34 INFO - '_': '/tools/buildbot/bin/python'} 05:15:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:34 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 05:15:34 INFO - Cleaning up... 05:15:34 INFO - Return code: 0 05:15:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:15: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')]} 05:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15: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')]} 05:15:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xa561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc22a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc2eb0>, '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 0xdc3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc4240>, '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': '51fc86400edbde9650d2781a000001d0-1500724630.712852-635091411', '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 05:15:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:15:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:15:34 INFO - Using env: {'DISPLAY': ':0', 05:15:34 INFO - 'HOME': '/home/cltbld', 05:15:34 INFO - 'LANG': 'en_US.UTF-8', 05:15:34 INFO - 'LANGUAGE': 'en_US:en', 05:15:34 INFO - 'LOGNAME': 'cltbld', 05:15:34 INFO - 'MAIL': '/var/mail/cltbld', 05:15:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:34 INFO - 'MOZ_NO_REMOTE': '1', 05:15:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:34 INFO - 'NO_EM_RESTART': '1', 05:15:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:34 INFO - 'PWD': '/builds/slave/test', 05:15:34 INFO - 'SHELL': '/bin/bash', 05:15:34 INFO - 'SHLVL': '1', 05:15:34 INFO - 'TERM': 'linux', 05:15:34 INFO - 'TMOUT': '86400', 05:15:34 INFO - 'USER': 'cltbld', 05:15:34 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1500724630.712852-635091411', 05:15:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:34 INFO - '_': '/tools/buildbot/bin/python'} 05:15:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:34 INFO - Downloading/unpacking psutil>=3.1.1 05:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:15:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:15:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:15:35 INFO - Installing collected packages: psutil 05:15:35 INFO - Running setup.py install for psutil 05:15:35 INFO - building 'psutil._psutil_linux' extension 05:15:35 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 05:15:35 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 05:15:35 INFO - building 'psutil._psutil_posix' extension 05:15:35 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 05:15:36 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 05:15:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:15:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:15:36 INFO - Successfully installed psutil 05:15:36 INFO - Cleaning up... 05:15:36 INFO - Return code: 0 05:15:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:15:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:36 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 0xa561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc22a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc2eb0>, '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 0xdc3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc4240>, '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': '51fc86400edbde9650d2781a000001d0-1500724630.712852-635091411', '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 05:15:36 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 05:15:36 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 05:15:36 INFO - Using env: {'DISPLAY': ':0', 05:15:36 INFO - 'HOME': '/home/cltbld', 05:15:36 INFO - 'LANG': 'en_US.UTF-8', 05:15:36 INFO - 'LANGUAGE': 'en_US:en', 05:15:36 INFO - 'LOGNAME': 'cltbld', 05:15:36 INFO - 'MAIL': '/var/mail/cltbld', 05:15:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:36 INFO - 'MOZ_NO_REMOTE': '1', 05:15:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:36 INFO - 'NO_EM_RESTART': '1', 05:15:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:36 INFO - 'PWD': '/builds/slave/test', 05:15:36 INFO - 'SHELL': '/bin/bash', 05:15:36 INFO - 'SHLVL': '1', 05:15:36 INFO - 'TERM': 'linux', 05:15:36 INFO - 'TMOUT': '86400', 05:15:36 INFO - 'USER': 'cltbld', 05:15:36 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1500724630.712852-635091411', 05:15:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:36 INFO - '_': '/tools/buildbot/bin/python'} 05:15:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:15:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:15:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:15:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:15:37 INFO - Installing collected packages: mozsystemmonitor 05:15:37 INFO - Running setup.py install for mozsystemmonitor 05:15:37 INFO - Successfully installed mozsystemmonitor 05:15:37 INFO - Cleaning up... 05:15:37 INFO - Return code: 0 05:15:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:15:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:37 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 0xa561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc22a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc2eb0>, '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 0xdc3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc4240>, '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': '51fc86400edbde9650d2781a000001d0-1500724630.712852-635091411', '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 05:15:37 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 05:15:37 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 05:15:37 INFO - Using env: {'DISPLAY': ':0', 05:15:37 INFO - 'HOME': '/home/cltbld', 05:15:37 INFO - 'LANG': 'en_US.UTF-8', 05:15:37 INFO - 'LANGUAGE': 'en_US:en', 05:15:37 INFO - 'LOGNAME': 'cltbld', 05:15:37 INFO - 'MAIL': '/var/mail/cltbld', 05:15:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:37 INFO - 'MOZ_NO_REMOTE': '1', 05:15:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:37 INFO - 'NO_EM_RESTART': '1', 05:15:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:37 INFO - 'PWD': '/builds/slave/test', 05:15:37 INFO - 'SHELL': '/bin/bash', 05:15:37 INFO - 'SHLVL': '1', 05:15:37 INFO - 'TERM': 'linux', 05:15:37 INFO - 'TMOUT': '86400', 05:15:37 INFO - 'USER': 'cltbld', 05:15:37 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1500724630.712852-635091411', 05:15:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:37 INFO - '_': '/tools/buildbot/bin/python'} 05:15:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:37 INFO - Downloading/unpacking jsonschema==2.5.1 05:15:37 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 05:15:37 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 05:15:37 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 05:15:37 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 05:15:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:15:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:15:39 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 05:15:39 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 05:15:39 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 05:15:39 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 05:15:39 INFO - Downloading functools32-3.2.3-2.tar.gz 05:15:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:15:39 INFO - warning: no files found matching '*.txt' 05:15:39 INFO - no previously-included directories found matching 'build' 05:15:39 INFO - no previously-included directories found matching 'dist' 05:15:39 INFO - no previously-included directories found matching '.git*' 05:15:39 INFO - Installing collected packages: jsonschema, functools32 05:15:39 INFO - Running setup.py install for functools32 05:15:39 INFO - warning: no files found matching '*.txt' 05:15:39 INFO - no previously-included directories found matching 'build' 05:15:39 INFO - no previously-included directories found matching 'dist' 05:15:39 INFO - no previously-included directories found matching '.git*' 05:15:39 INFO - Successfully installed jsonschema functools32 05:15:39 INFO - Cleaning up... 05:15:39 INFO - Return code: 0 05:15:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:39 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 0xa561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc22a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc2eb0>, '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 0xdc3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc4240>, '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': '51fc86400edbde9650d2781a000001d0-1500724630.712852-635091411', '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 05:15:39 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 05:15:39 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 05:15:39 INFO - Using env: {'DISPLAY': ':0', 05:15:39 INFO - 'HOME': '/home/cltbld', 05:15:39 INFO - 'LANG': 'en_US.UTF-8', 05:15:39 INFO - 'LANGUAGE': 'en_US:en', 05:15:39 INFO - 'LOGNAME': 'cltbld', 05:15:39 INFO - 'MAIL': '/var/mail/cltbld', 05:15:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:39 INFO - 'MOZ_NO_REMOTE': '1', 05:15:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:39 INFO - 'NO_EM_RESTART': '1', 05:15:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:39 INFO - 'PWD': '/builds/slave/test', 05:15:39 INFO - 'SHELL': '/bin/bash', 05:15:39 INFO - 'SHLVL': '1', 05:15:39 INFO - 'TERM': 'linux', 05:15:39 INFO - 'TMOUT': '86400', 05:15:39 INFO - 'USER': 'cltbld', 05:15:39 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1500724630.712852-635091411', 05:15:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:39 INFO - '_': '/tools/buildbot/bin/python'} 05:15:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:15:39 INFO - Cleaning up... 05:15:39 INFO - Return code: 0 05:15:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:39 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 0xa561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc22a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc2eb0>, '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 0xdc3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc4240>, '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': '51fc86400edbde9650d2781a000001d0-1500724630.712852-635091411', '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 05:15:39 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 05:15:39 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 05:15:39 INFO - Using env: {'DISPLAY': ':0', 05:15:39 INFO - 'HOME': '/home/cltbld', 05:15:39 INFO - 'LANG': 'en_US.UTF-8', 05:15:39 INFO - 'LANGUAGE': 'en_US:en', 05:15:39 INFO - 'LOGNAME': 'cltbld', 05:15:39 INFO - 'MAIL': '/var/mail/cltbld', 05:15:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:39 INFO - 'MOZ_NO_REMOTE': '1', 05:15:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:39 INFO - 'NO_EM_RESTART': '1', 05:15:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:39 INFO - 'PWD': '/builds/slave/test', 05:15:39 INFO - 'SHELL': '/bin/bash', 05:15:39 INFO - 'SHLVL': '1', 05:15:39 INFO - 'TERM': 'linux', 05:15:39 INFO - 'TMOUT': '86400', 05:15:39 INFO - 'USER': 'cltbld', 05:15:39 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1500724630.712852-635091411', 05:15:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:39 INFO - '_': '/tools/buildbot/bin/python'} 05:15:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:39 INFO - Downloading/unpacking blobuploader==1.2.4 05:15:39 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 05:15:39 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 05:15:39 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 05:15:39 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 05:15:40 INFO - Downloading blobuploader-1.2.4.tar.gz 05:15:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:15:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:15:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:41 INFO - Downloading docopt-0.6.1.tar.gz 05:15:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:15:41 INFO - Installing collected packages: blobuploader, requests, docopt 05:15:41 INFO - Running setup.py install for blobuploader 05:15:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:15:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:15:41 INFO - Running setup.py install for requests 05:15:42 INFO - Running setup.py install for docopt 05:15:42 INFO - Successfully installed blobuploader requests docopt 05:15:42 INFO - Cleaning up... 05:15:42 INFO - Return code: 0 05:15:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:42 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 0xa561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc22a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc2eb0>, '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 0xdc3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc4240>, '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': '51fc86400edbde9650d2781a000001d0-1500724630.712852-635091411', '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 05:15:42 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 05:15:42 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 05:15:42 INFO - Using env: {'DISPLAY': ':0', 05:15:42 INFO - 'HOME': '/home/cltbld', 05:15:42 INFO - 'LANG': 'en_US.UTF-8', 05:15:42 INFO - 'LANGUAGE': 'en_US:en', 05:15:42 INFO - 'LOGNAME': 'cltbld', 05:15:42 INFO - 'MAIL': '/var/mail/cltbld', 05:15:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:42 INFO - 'MOZ_NO_REMOTE': '1', 05:15:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:42 INFO - 'NO_EM_RESTART': '1', 05:15:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:42 INFO - 'PWD': '/builds/slave/test', 05:15:42 INFO - 'SHELL': '/bin/bash', 05:15:42 INFO - 'SHLVL': '1', 05:15:42 INFO - 'TERM': 'linux', 05:15:42 INFO - 'TMOUT': '86400', 05:15:42 INFO - 'USER': 'cltbld', 05:15:42 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1500724630.712852-635091411', 05:15:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:42 INFO - '_': '/tools/buildbot/bin/python'} 05:15:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:15:42 INFO - Running setup.py (path:/tmp/pip-pQfvUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:15:42 INFO - Running setup.py (path:/tmp/pip-4_M0K_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:15:42 INFO - Running setup.py (path:/tmp/pip-DMDhkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:15:42 INFO - Running setup.py (path:/tmp/pip-peDnbl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:15:42 INFO - Running setup.py (path:/tmp/pip-Fah6Hw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:15:42 INFO - Running setup.py (path:/tmp/pip-FTDvn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:15:43 INFO - Running setup.py (path:/tmp/pip-4mUhfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:15:43 INFO - Running setup.py (path:/tmp/pip-vjXRxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:15:43 INFO - Running setup.py (path:/tmp/pip-wY25Lc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:15:43 INFO - Running setup.py (path:/tmp/pip-BQKh16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:15:43 INFO - Running setup.py (path:/tmp/pip-Um5byl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:15:43 INFO - Running setup.py (path:/tmp/pip-bJ1v3X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:15:43 INFO - Running setup.py (path:/tmp/pip-WYv9h9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:15:43 INFO - Running setup.py (path:/tmp/pip-1v7NaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:43 INFO - Running setup.py (path:/tmp/pip-Od71cZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:15:43 INFO - Running setup.py (path:/tmp/pip-Ti32sB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:15:43 INFO - Running setup.py (path:/tmp/pip-9rA5U2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:15:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:15:44 INFO - Running setup.py install for manifestparser 05:15:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:15:44 INFO - Running setup.py install for mozcrash 05:15:44 INFO - Running setup.py install for mozdebug 05:15:44 INFO - Running setup.py install for mozdevice 05:15:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:15:44 INFO - Running setup.py install for mozfile 05:15:44 INFO - Running setup.py install for mozhttpd 05:15:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:15:44 INFO - Running setup.py install for mozinfo 05:15:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:15:44 INFO - Running setup.py install for mozInstall 05:15:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:15:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:15:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:15:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:15:44 INFO - Running setup.py install for mozleak 05:15:44 INFO - Running setup.py install for mozlog 05:15:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:15:45 INFO - Running setup.py install for moznetwork 05:15:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:15:45 INFO - Running setup.py install for mozprocess 05:15:45 INFO - Running setup.py install for mozprofile 05:15:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:15:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:15:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:15:45 INFO - Running setup.py install for mozrunner 05:15:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:15:45 INFO - Running setup.py install for mozscreenshot 05:15:45 INFO - Running setup.py install for moztest 05:15:45 INFO - Running setup.py install for mozversion 05:15:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:15:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:15:45 INFO - Cleaning up... 05:15:45 INFO - Return code: 0 05:15:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:15:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:45 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 0xa561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc22a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc2eb0>, '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 0xdc3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc4240>, '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': '51fc86400edbde9650d2781a000001d0-1500724630.712852-635091411', '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 05:15:45 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 05:15:45 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 05:15:45 INFO - Using env: {'DISPLAY': ':0', 05:15:45 INFO - 'HOME': '/home/cltbld', 05:15:45 INFO - 'LANG': 'en_US.UTF-8', 05:15:45 INFO - 'LANGUAGE': 'en_US:en', 05:15:45 INFO - 'LOGNAME': 'cltbld', 05:15:45 INFO - 'MAIL': '/var/mail/cltbld', 05:15:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:45 INFO - 'MOZ_NO_REMOTE': '1', 05:15:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:45 INFO - 'NO_EM_RESTART': '1', 05:15:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:45 INFO - 'PWD': '/builds/slave/test', 05:15:45 INFO - 'SHELL': '/bin/bash', 05:15:45 INFO - 'SHLVL': '1', 05:15:45 INFO - 'TERM': 'linux', 05:15:45 INFO - 'TMOUT': '86400', 05:15:45 INFO - 'USER': 'cltbld', 05:15:45 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1500724630.712852-635091411', 05:15:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:45 INFO - '_': '/tools/buildbot/bin/python'} 05:15:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:15:46 INFO - Running setup.py (path:/tmp/pip-3HYTqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:15:46 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)) 05:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:15:46 INFO - Running setup.py (path:/tmp/pip-fmGBe0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:15:46 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)) 05:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:15:46 INFO - Running setup.py (path:/tmp/pip-Vvc3_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:15:46 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)) 05:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:15:46 INFO - Running setup.py (path:/tmp/pip-qpPhqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:15:46 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)) 05:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:15:46 INFO - Running setup.py (path:/tmp/pip-6RCcf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:15:46 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)) 05:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:15:46 INFO - Running setup.py (path:/tmp/pip-YFIN5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:15:46 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)) 05:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:15:46 INFO - Running setup.py (path:/tmp/pip-hhrjph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:15:46 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)) 05:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:15:46 INFO - Running setup.py (path:/tmp/pip-6irhqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:15:46 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)) 05:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:15:46 INFO - Running setup.py (path:/tmp/pip-vkgmPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:15:46 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)) 05:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:15:46 INFO - Running setup.py (path:/tmp/pip-evUBJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:15:46 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)) 05:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:15:46 INFO - Running setup.py (path:/tmp/pip-99Wgs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:15:46 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)) 05:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:15:46 INFO - Running setup.py (path:/tmp/pip-yBviUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:15:46 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)) 05:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:15:46 INFO - Running setup.py (path:/tmp/pip-2t3vYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:15:46 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)) 05:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:15:46 INFO - Running setup.py (path:/tmp/pip-3oCu9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:15:47 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)) 05:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:47 INFO - Running setup.py (path:/tmp/pip-BmiNLh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:47 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)) 05:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:15:47 INFO - Running setup.py (path:/tmp/pip-8utzqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:15:47 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)) 05:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:15:47 INFO - Running setup.py (path:/tmp/pip-5pWS4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:15:47 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)) 05:15:47 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)) 05:15:47 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)) 05:15:47 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)) 05:15:47 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)) 05:15:47 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)) 05:15:47 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)) 05:15:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:15:47 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 05:15:47 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 05:15:47 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 05:15:47 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 05:15:48 INFO - Downloading blessings-1.6.tar.gz 05:15:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:15:48 INFO - Installing collected packages: blessings 05:15:48 INFO - Running setup.py install for blessings 05:15:48 INFO - Successfully installed blessings 05:15:48 INFO - Cleaning up... 05:15:48 INFO - Return code: 0 05:15:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:15:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:15:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:15:48 INFO - Reading from file tmpfile_stdout 05:15:48 INFO - Current package versions: 05:15:48 INFO - argparse == 1.2.1 05:15:48 INFO - blessings == 1.6 05:15:48 INFO - blobuploader == 1.2.4 05:15:48 INFO - docopt == 0.6.1 05:15:48 INFO - functools32 == 3.2.3-2 05:15:48 INFO - jsonschema == 2.5.1 05:15:48 INFO - manifestparser == 1.1 05:15:48 INFO - mozInstall == 1.13 05:15:48 INFO - mozcrash == 1.0 05:15:48 INFO - mozdebug == 0.1 05:15:48 INFO - mozdevice == 0.51 05:15:48 INFO - mozfile == 1.2 05:15:48 INFO - mozhttpd == 0.7 05:15:48 INFO - mozinfo == 0.10 05:15:48 INFO - mozleak == 0.1 05:15:48 INFO - mozlog == 3.5 05:15:48 INFO - moznetwork == 0.27 05:15:48 INFO - mozprocess == 0.25 05:15:48 INFO - mozprofile == 0.28 05:15:48 INFO - mozrunner == 6.13 05:15:48 INFO - mozscreenshot == 0.1 05:15:48 INFO - mozsystemmonitor == 0.3 05:15:48 INFO - moztest == 0.8 05:15:48 INFO - mozversion == 1.4 05:15:48 INFO - psutil == 3.1.1 05:15:48 INFO - requests == 1.2.3 05:15:48 INFO - wsgiref == 0.1.2 05:15:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:15:48 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')]} 05:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:48 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')]} 05:15:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:48 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 0xa561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc22a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc2eb0>, '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 0xdc3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc4240>, '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': '51fc86400edbde9650d2781a000001d0-1500724630.712852-635091411', '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 05:15:48 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 05:15:48 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 05:15:48 INFO - Using env: {'DISPLAY': ':0', 05:15:48 INFO - 'HOME': '/home/cltbld', 05:15:48 INFO - 'LANG': 'en_US.UTF-8', 05:15:48 INFO - 'LANGUAGE': 'en_US:en', 05:15:48 INFO - 'LOGNAME': 'cltbld', 05:15:48 INFO - 'MAIL': '/var/mail/cltbld', 05:15:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:48 INFO - 'MOZ_NO_REMOTE': '1', 05:15:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:48 INFO - 'NO_EM_RESTART': '1', 05:15:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:48 INFO - 'PWD': '/builds/slave/test', 05:15:48 INFO - 'SHELL': '/bin/bash', 05:15:48 INFO - 'SHLVL': '1', 05:15:48 INFO - 'TERM': 'linux', 05:15:48 INFO - 'TMOUT': '86400', 05:15:48 INFO - 'USER': 'cltbld', 05:15:48 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1500724630.712852-635091411', 05:15:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:48 INFO - '_': '/tools/buildbot/bin/python'} 05:15:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:49 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)) 05:15:49 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)) 05:15:49 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)) 05:15:49 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)) 05:15:49 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)) 05:15:49 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)) 05:15:49 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)) 05:15:49 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)) 05:15:49 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)) 05:15:49 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:15:49 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 05:15:49 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 05:15:49 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 05:15:49 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 05:15:50 INFO - Downloading marionette_driver-1.4.0.tar.gz 05:15:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 05:15:50 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 05:15:50 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 05:15:50 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 05:15:50 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 05:15:50 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 05:15:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 05:15:50 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)) 05:15:50 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)) 05:15:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:15:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:15:50 INFO - Installing collected packages: marionette-driver, simplejson 05:15:50 INFO - Running setup.py install for marionette-driver 05:15:50 INFO - Running setup.py install for simplejson 05:15:50 INFO - building 'simplejson._speedups' extension 05:15:50 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 05:15:51 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 05:15:51 INFO - Successfully installed marionette-driver simplejson 05:15:51 INFO - Cleaning up... 05:15:51 INFO - Return code: 0 05:15:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:15:51 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')]} 05:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:51 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')]} 05:15:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:51 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 0xa561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc22a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc2eb0>, '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 0xdc3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc4240>, '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': '51fc86400edbde9650d2781a000001d0-1500724630.712852-635091411', '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 05:15:51 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 05:15:51 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 05:15:51 INFO - Using env: {'DISPLAY': ':0', 05:15:51 INFO - 'HOME': '/home/cltbld', 05:15:51 INFO - 'LANG': 'en_US.UTF-8', 05:15:51 INFO - 'LANGUAGE': 'en_US:en', 05:15:51 INFO - 'LOGNAME': 'cltbld', 05:15:51 INFO - 'MAIL': '/var/mail/cltbld', 05:15:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:51 INFO - 'MOZ_NO_REMOTE': '1', 05:15:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:51 INFO - 'NO_EM_RESTART': '1', 05:15:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:51 INFO - 'PWD': '/builds/slave/test', 05:15:51 INFO - 'SHELL': '/bin/bash', 05:15:51 INFO - 'SHLVL': '1', 05:15:51 INFO - 'TERM': 'linux', 05:15:51 INFO - 'TMOUT': '86400', 05:15:51 INFO - 'USER': 'cltbld', 05:15:51 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1500724630.712852-635091411', 05:15:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:51 INFO - '_': '/tools/buildbot/bin/python'} 05:15:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:15:51 INFO - Cleaning up... 05:15:51 INFO - Return code: 0 05:15:51 INFO - Running post-action listener: _resource_record_post_action 05:15:51 INFO - Running post-action listener: _start_resource_monitoring 05:15:51 INFO - Starting resource monitoring. 05:15:51 INFO - [mozharness: 2017-07-22 12:15:51.848874Z] Finished create-virtualenv step (success) 05:15:51 INFO - [mozharness: 2017-07-22 12:15:51.849444Z] Running install step. 05:15:51 INFO - Running pre-action listener: _resource_record_pre_action 05:15:51 INFO - Running main action method: install 05:15:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:15:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:15:52 INFO - Reading from file tmpfile_stdout 05:15:52 INFO - Detecting whether we're running mozinstall >=1.0... 05:15:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:15:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:15:52 INFO - Reading from file tmpfile_stdout 05:15:52 INFO - Output received: 05:15:52 INFO - Usage: mozinstall [options] installer 05:15:52 INFO - Options: 05:15:52 INFO - -h, --help show this help message and exit 05:15:52 INFO - -d DEST, --destination=DEST 05:15:52 INFO - Directory to install application into. [default: 05:15:52 INFO - "/builds/slave/test"] 05:15:52 INFO - --app=APP Application being installed. [default: firefox] 05:15:52 INFO - mkdir: /builds/slave/test/build/application 05:15:52 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'] 05:15:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:16:10 INFO - Reading from file tmpfile_stdout 05:16:10 INFO - Output received: 05:16:10 INFO - /builds/slave/test/build/application/firefox/firefox 05:16:10 INFO - Running post-action listener: _resource_record_post_action 05:16:10 INFO - [mozharness: 2017-07-22 12:16:10.039930Z] Finished install step (success) 05:16:10 INFO - [mozharness: 2017-07-22 12:16:10.040185Z] Running setup-mitmproxy step. 05:16:10 INFO - Running pre-action listener: _resource_record_pre_action 05:16:10 INFO - Running main action method: setup_mitmproxy 05:16:10 INFO - Skipping: mitmproxy is not required 05:16:10 INFO - Running post-action listener: _resource_record_post_action 05:16:10 INFO - [mozharness: 2017-07-22 12:16:10.041324Z] Finished setup-mitmproxy step (success) 05:16:10 INFO - [mozharness: 2017-07-22 12:16:10.041615Z] Running run-tests step. 05:16:10 INFO - Running pre-action listener: _resource_record_pre_action 05:16:10 INFO - Running pre-action listener: _set_gcov_prefix 05:16:10 INFO - Running main action method: run_tests 05:16:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:16:10 INFO - Python 2.7.3 05:16:10 INFO - Return code: 0 05:16:10 INFO - grabbing minidump binary from tooltool 05:16: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')]} 05:16:10 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 0xdc2eb0>, '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 0xdc3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc4240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:16:10 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 05:16:10 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 05:16:10 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 05:16:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:16:10 INFO - Return code: 0 05:16:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:16:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:16:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:16:10 INFO - ENV: RUST_BACKTRACE is now 1 05:16:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:16:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:16:10 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/XJOKhumSTkeEvXj_ZHnCCQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-082', '--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 05:16:10 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/XJOKhumSTkeEvXj_ZHnCCQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-082 --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 05:16:10 INFO - Using env: {'DISPLAY': ':0', 05:16:10 INFO - 'HOME': '/home/cltbld', 05:16:10 INFO - 'LANG': 'en_US.UTF-8', 05:16:10 INFO - 'LANGUAGE': 'en_US:en', 05:16:10 INFO - 'LOGNAME': 'cltbld', 05:16:10 INFO - 'MAIL': '/var/mail/cltbld', 05:16:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:16:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:16:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:10 INFO - 'MOZ_NO_REMOTE': '1', 05:16:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:16:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:10 INFO - 'NO_EM_RESTART': '1', 05:16:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:10 INFO - 'PWD': '/builds/slave/test', 05:16:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:16:10 INFO - 'RUST_BACKTRACE': '1', 05:16:10 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:16:10 INFO - 'SHELL': '/bin/bash', 05:16:10 INFO - 'SHLVL': '1', 05:16:10 INFO - 'TERM': 'linux', 05:16:10 INFO - 'TMOUT': '86400', 05:16:10 INFO - 'USER': 'cltbld', 05:16:10 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1500724630.712852-635091411', 05:16:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:10 INFO - '_': '/tools/buildbot/bin/python'} 05:16:10 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/XJOKhumSTkeEvXj_ZHnCCQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-082', '--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 05:16:10 INFO - mozversion application_buildid: 20170722111228 05:16:10 INFO - mozversion application_changeset: 7ce557b85b611536b69539a7c18d4834ffc92eea 05:16:10 INFO - mozversion application_display_name: Nightly 05:16:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:16:10 INFO - mozversion application_name: Firefox 05:16:10 INFO - mozversion application_remotingname: firefox 05:16:10 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:16:10 INFO - mozversion application_vendor: Mozilla 05:16:10 INFO - mozversion application_version: 56.0a1 05:16:10 INFO - mozversion platform_buildid: 20170722111228 05:16:10 INFO - mozversion platform_changeset: 7ce557b85b611536b69539a7c18d4834ffc92eea 05:16:10 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:16:10 INFO - mozversion platform_version: 56.0a1 05:16:10 INFO - using testdate: 1500725770 05:16:10 INFO - actual date: 1500725770 05:16:10 INFO - starting webserver on 'localhost:44304' 05:16:10 INFO - SUITE-START | Running 2 tests 05:16:10 INFO - TEST-START | dromaeo_css 05:16:10 INFO - Initialising browser for dromaeo_css test... 05:16:10 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44304/getInfo.html -profile /tmp/tmpWHsKT1/profile 05:16:10 INFO - TEST-INFO | started process 14410 (/builds/slave/test/build/application/firefox/firefox http://localhost:44304/getInfo.html) 05:16:16 INFO - TEST-INFO | 14410: exit 0 05:16:16 INFO - Browser initialized. 05:16:16 INFO - Running cycle 1/1 for dromaeo_css test... 05:16:16 INFO - TEST-INFO | started process 14631 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWHsKT1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:16:27 INFO - PID 14631 | RSS: Main: 167219200 05:16:27 INFO - PID 14631 | 05:19:25 INFO - PID 14631 | Cycle 1(1): loaded http://localhost:44304/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44304/tests/dromaeo/cssquery-ext.html) 05:19:26 INFO - PID 14631 | RSS: Main: 173256704 05:19:26 INFO - PID 14631 | 05:22:28 INFO - PID 14631 | Cycle 1(1): loaded http://localhost:44304/tests/dromaeo/cssquery-ext.html (next: http://localhost:44304/tests/dromaeo/cssquery-jquery.html) 05:22:29 INFO - PID 14631 | RSS: Main: 170397696 05:22:29 INFO - PID 14631 | 05:25:30 INFO - PID 14631 | Cycle 1(1): loaded http://localhost:44304/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44304/tests/dromaeo/cssquery-mootools.html) 05:25:31 INFO - PID 14631 | RSS: Main: 172449792 05:25:31 INFO - PID 14631 | 05:28:33 INFO - PID 14631 | Cycle 1(1): loaded http://localhost:44304/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44304/tests/dromaeo/cssquery-prototype.html) 05:28:33 INFO - PID 14631 | RSS: Main: 171163648 05:28:33 INFO - PID 14631 | 05:31:37 INFO - PID 14631 | Cycle 1(1): loaded http://localhost:44304/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44304/tests/dromaeo/cssquery-yui.html) 05:31:37 INFO - PID 14631 | RSS: Main: 172748800 05:31:37 INFO - PID 14631 | 05:34:39 INFO - PID 14631 | Cycle 1(1): loaded http://localhost:44304/tests/dromaeo/cssquery-yui.html (next: http://localhost:44304/tests/dromaeo/cssquery-dojo.html) 05:34:39 INFO - PID 14631 | RSS: Main: 175296512 05:34:39 INFO - PID 14631 | 05:34:39 INFO - PID 14631 | __start_tp_report 05:34:39 INFO - PID 14631 | _x_x_mozilla_page_load 05:34:39 INFO - PID 14631 | _x_x_mozilla_page_load_details 05:34:39 INFO - PID 14631 | |i|pagename|runs| 05:34:39 INFO - PID 14631 | |0;dojo.html;3349.4305967985424;3386.1026827890605;3389.4237979543477;3410.5907291125063;3459.481077838324;5979.581429299951;6168.814935551935;6179.042248451486;6179.289381721103;6183.938160618398;6046.365131661168;6143.784967526138;6149.877002459948;6156.168917196188;6222.5955312904625;5420.891582168354;5421;5435.456454354572;5438.075527160392;5505.504504594585;5120.692758434506;5280.234366016925;5438.15708565173;5538.833834984957;5542.251796007527;5392.299001129867;5410.5401040911765;5460.808871689512;5469.179623056553;5471.781128754845;5330.880515091835;5429.239906413105;5471.562275017989;5482.424345443751;5491.176323551459;5369.114096174127;5376.220448035052;5378.838634840961;5418.45815418455;5435.266239057716;6091.451769340736;6093.512518998469;6112.022076467788;6126.387361263883;6173.135760993465;6516.804495865132;6582.24304205013;6668.566543174727;6711.664416779142;6743.426808721265;6698.665066746692;6800.829979250509;6804.591724496546;6817.965910170467;6821.727130914757;6176.258848938111;6193.783217587363;6204.286507051656;6277.591956522857;6288.968555157195;6706.094677218611;6744.865102697919;6850;6878.759243426456;6932.896006559906;6545.247296560861;6552.344765523505;6556.344365563501;6565.573237739532;6571.80284591463;6656.833579160463;6665.500087493458;6730.091437655854;6733.124693789874;6753.257141714407;6605.70274337656;6630.071789949411;6664.633445160563;6729.596224226562;6743.123393958852;6578.901316480256;6608.669566521655;6626.801195964129;6634.436072933758;6714.294999025032;4792.520747925179;4816.662833601615;4817.253325734517;4830.203016502238;4861.149298872683;4247.17180149874;4293.119910418419;4319.67602429819;4341.674374421931;4343.131373725268;6215.502759779207;6251.12484252205;6291.182146320949;6430.678466076677;6432.324605916405;6603.7358505660195;6680.365365290289;6680.933190668031;6699.263081061079;6708.765193218214;6429.549931504844;6473.838154046092;6514.609123452608;6523.988781738838;6554.147960765165;5393.406725260218;5461.590380721462;5467.234587157801;5554.250176226238;5554.861128471821;7120.537165084356;7238.819029524198;7239.927600723925;7262.419006479469;7266.745663901738;6682.63245521501;6685.231198412245;6749.122614060141;6761.459083273228;6775.932240677727;6995.650217489004;7088.184858741104;7094.184168820651;7129.322714342129;7232.674529646073;6529.771457998947;6542.607443553402;6548.246951600627;6554.115194448688;6581.3747693969;6739.191297044386;6743.15710536183;6779.55932864382;6820.249772525118;6828.351306625863;6526.804195874131;6533.967330163318;6599.439047681001;6610.041543976193;6622.90065649006;6398.808035758934;6444;6455.0640157176;6521.217453905561;6570.408663220333;6492.188476440445;6531.967340163269;6569.868602628017;6574.934250657432;6576.671166441563;6551.475881929529;6564.376384243489;6596.835079122869;6669.0996715444735;6671.6997735103005;6304.936950630618;6338.366163383809;6354.332795056637;6380.298167201511;6407.359264073555 05:34:39 INFO - PID 14631 | |1;ext.html;893.9659760689151;910.3718434280346;921.5484412637808;957.1433566957569;958.3674774648729;43544.99999999996;44218;44321.89195270116;44410;44456.77771611138;40172.79913600435;40268.39597406041;40446.19107617846;40514.79742601283;40567.79716101423;6736.191657001143;6841.350071743202;6850;6855;6869.175698916137;6731.93268067318;6804.149481314836;6805.625690587016;6806.455483561328;6823.863522729543;6784.660766961632;6821.215560210565;7429.479936404454;7601.923980760204;7606.087269527665;7505.399568034544;7564.470487065908;7566;7567.281108294703;7590.962045189794;7009.088818453569;7377.151627562792;7481.102267727853;7493.737719179857;7516.173220945691;40335.596644033474;40528.797356013325;40748.796256018824;40749;40850.79574602138;3494.3884820156627;3508.8947331580093;3515.367233897897;3525.3478106550115;3544.6987006104514;31881.202969925704;31938.840305798323;31977;32145.51781723276;32221.194470138198;5094.363204599425;5113.948860511385;5122.820701275437;5133.255677926717;5137.357830271216;215563;215813;216727.99999999843;216894;216929;52191.47808521942;52230;52289.738551307;52295.47704522982;52333.47666523362;54939;54978;55020.724896376065;55039.724801376535;55074.44925550693;16584.66830663404;16895.577610559587;16896.493105206864;16919.323227071025;16920.40778572744;13673.931630341785;13685.178889266675;13686.726265474834;13688.65778355549;13693.657658558615;15341.386344546316;15365.154916479702;15366.231688415535;15402.691946161014;15519.1464469453;5945.64326140433;6124.418180272867;6132.141500189977;6176.363263735114;6197.783077592263;1068.3536460441476;1076.9569217231224;1077.1167642533048;1078.369154044877;1085.9619913302997;31378.21554461157;31876;32612;32857.83571082177;33544.83227583847;1160.6924165096257;1164.6738913104343;1172.9472173752201;1174.3247632611283;1190.3274649822822;12950.546730864375;13287.076843094505;13435.865641343462;13458.327083645778;13626.523071692443;269215;269369;269681;269974;270350;51558;51638.22542661863;60688.69655651782;63942.36057639364;64109.67945160338;1461.2839708542738;1509.645233370157;1513.2206913439588;1527.6715506166006;1542.2288855572215;30027.54958675578;30397.848010759804;30631.846840765655;30927;31012.534811977388;40985.795071024455;41485;41507.75476735703;41578;41578.168436631706;230585;230729;230752;231629;232152;37726.811365942995;37870.81064594659;37918.24163516659;37944.620553794106;38264.61735382611;45577;46024.30963535616;46385.30422043739;46927.76536117298;46990.53009469862;32936.67063329336;33012.50481242831;34937.47593786146;34971;35101;33574.32851342911;34021.31957360789;34916.65083349236;34961.12597184989;35195;35844.64155358413;35937.82031089828;42659.146817062865;44004.33993490164;44303.55696442995;34401;35061.82469087638;35951.640483595875;36493;36790;25531.489370212865;26393.736062639127;27045;27290;27331.31671708223 05:34:39 INFO - PID 14631 | |2;jquery.html;533.991990120148;553.4189101443484;555.7638003848368;558.3439458636103;590.2385922160413;22637.886810565946;22963.77036229637;23510.059597616117;23525;23574.88212558937;27150.45699086017;27606;27678.723212767865;27721.30696732583;27746.722532774667;6209.720562574673;6262.686865656722;6304.842378940541;6349.301576826545;6351.17434733484;5783.9710801445935;6381.840453988641;6413.294537600884;6416.4225219730215;6419.518536109787;6364.809055728336;6371.267304260023;6374.968125159367;6385.457236134911;6397.5521713480075;6309.08518264849;6326.65203413812;6338.0492926061;6346.270178929413;6360.9045864312075;5908.586398952075;5915.792947246826;5917.881642367129;5930.229070220844;5941.2276404067625;28512.857435712896;30782.53826192609;30990.450477476035;31153.376932461222;31241.218969525715;2183.639699449589;2237.4182712494867;2243.013074247342;2244.1808739810017;2247.797698207169;19597.21611135553;19633.116509756954;19747.605047899106;19870.90064549668;20025.699614505793;2377.5601513720017;2438.366024833538;2446.7063952325834;2448.069733501276;2450.2894160693377;152355;154838;155523;155958;156284;15889;16033.438829640907;16127.354905803872;16136.35454581827;16204.43284485061;24209;24315.148969786325;24383.7561624385;24399.536027838385;24443.266701998968;9968.850467242997;10542.841857372145;10620;10622.628208012682;10665.680029599125;9171.954140229389;9600.567974441166;9604.423734575948;9728.902710972941;9829.606815727291;9403.529823508934;9627.470489123025;9996.150327222122;10010.715442697388;10032.548535315927;2746.9725302746715;2753.408017276295;2784.610154578361;2790.2560899437854;2828.9575656365173;1055.0978913029403;1066.1257768629805;1072.1690689715533;1073.8013467508379;1079.1151255970028;20554.58890822175;21774.346769596938;26177.476450470884;26963.460730785275;27331;1086.071408945356;1100.658795773313;1101.9228653994303;1125.7241975716001;1139.6467095200348;11750.70623234426;11781.997060499736;12309.26144431337;12332.691682707824;12393.690157745948;568766;578589;588347;591945;595452;139103;140066.8676676914;140592.2970385162;140610;142318.2884085573;1275.2348590845418;1334.5395838435725;1337.358068127285;1356.7083077138464;1360.6462319796924;18146.364877229233;19602.803971960097;23054.308370748906;24197;24372.146974856503;63228.68385658226;64780.676096619216;64932;66318.66840665766;67135.66432167808;74076;74441.6277918607;75064.62467687845;75103.24896751181;75185.24814751782;14769;15385.538433847003;15391.61520961985;15415.383384664936;15420.228988550753;24191.879040604683;24462.388440289134;24860.62709059402;24877.502449950538;24946.875265623556;20072.397828065183;20321.49196270105;20340.186392544725;20415.183392664127;20579.58840823205;17498.73751893748;17574.297028118734;17688.64622707513;17982.550436238675;18817.341393051178;19018.23927042903;19112.139953701837;20634.587308254053;20813.89593052025;20964.161433543097;15002.399904003718;15138.621534461727;15248.466303679317;15256;15271.694566108394;20110.095045722686;20147;20165.193392264144;20206.29277975264;20350.491237719176 05:34:39 INFO - PID 14631 | |3;mootools.html;1429.5211104280068;1485.2499487758673;1485.4949317232147;1497.4908531099425;1507.7436835737926;14770.556883293504;15392.076475411483;15484.535463936072;15515.844841551581;15518.30167642456;15263.847361526381;15745.448909288178;15756.133412662299;15770.763438548402;15777.763333550007;2682.8658567071666;2718.293243756628;2720.07517444069;2725.2096891901324;2730.754232119109;2655.296346468178;2740.260129764962;2794.0360575601385;2794.203651959182;2794.3852352482522;2640.9339766505896;2735.7127501612244;2776.763975062122;2779.277387879146;2786.3312804926773;2557.488502299538;2572.498362819251;2599.805014623892;2600.1289567994745;2601.3106526770516;2583.935401614956;2594.507043661717;2599.922002339933;2617.790576753874;2631.8420894746378;14782;15048.548543543602;15081.698366032728;15091.924540377227;15105.39578416862;8132.18678132188;8428.873566896502;8452.366072544522;8457.492550446932;8462.280706139923;5078.4413714491375;5239.056969745444;5340.706261155635;5376.38171610262;5413.188021796723;1862.3854128137818;1866.2908094923978;1929.507975466261;1929.8263156315859;1949.2592814730453;25730.228093157235;25873.870630646914;25908;25926.35184120412;25931.611025834438;6696.732130714717;6812.557183783038;6830.419414349836;7030.894536581955;7168.354848063699;17804.46586602404;17937.641247175245;17952.551186220448;17992;18010.099495025195;7782.922170778333;7986.32116270112;8001.5599142046585;8023.1976802319305;8026.277635012877;6457.967710161419;6581.2760596334365;6873.381395674413;7218.061651985208;7729.227077292226;5256.763445644955;5392.811251606175;5431.918521222185;5451.209574611659;5456.208849716848;1484.1762821634097;1509.222750283605;1511.5994261520707;1520.4602366160075;1537.5464238049801;877.2718643525858;881.6164968238709;907.5598334807613;916.5737931861584;930.7533503621546;9789.559469823875;9859.161971232526;9877.308588398886;9986.800263994679;10264.589416423409;1017.8931212222758;1021.0912288063629;1046.0794500839365;1062.8990245926625;1069.8341757027674;5601.6358936668985;5845.532357411482;5888.939990801697;5942.435468630473;6128.050152226412;20588.485287867625;21427.464313391978;21667.67498487524;21668.45828854291;21686.240981565887;20859.791402085786;21203.257885974224;21378.679319810217;21388.78611213899;21413.250536231157;10805.189610779224;11184.832227516594;11245;11331.773364532663;11352.318860868374;8482.660693572188;8790.472571645465;8905.51019693923;9019.458832470073;9125.634974601207;18124.909375453037;18580.25678972826;18785.34251301198;18836.434906952814;19031.809681903556;18858.24567017304;18983.905080475062;18991.240350386382;19161.712574311117;19762.11070501802;12539.74920501603;13038.152520086163;13063.281519516519;13067.738645226853;13093.410796513988;14313.57059288223;14388.06477578954;14464.27678616086;14514.491992780202;14578.416863325772;11502.13733969939;11552;11654.125940554663;11723.237989530653;11896.702582435508;10809.837852432063;10998.395088269903;11110.16673749456;11294.94352528232;11558;9867.506624668882;10359.94820025895;10371.222158338003;10414.47927603632;10439.94780026095;7413.66638501258;7825.960870195612;8014.118446970712;8027.317677997436;8081.111077781322;7721.884171737316;7738.883916741141;7836.843263134591;7848.450608457581;8000.119986801331 05:34:39 INFO - PID 14631 | |4;prototype.html;483.50199294726434;491.4201242533809;522.2505704314309;523.3484312031517;532.488810741688;5963.671998040106;6001.2896324547455;6009.609375390602;6010.909836352458;6043.969780151093;5707.543396528278;5875.532276443893;5897.702505448805;5932.961731696957;5934.109883517474;4621.283701026337;4638.698484598491;4677.368555245032;4678.181318269306;4721.811127554911;4553;4711.740854253015;4731.290306454042;4737.336772851803;4743.501932297094;4621.79201935912;4670.392848929651;4671;4674.083625713458;4682.688847122794;4568.223402021665;4596.563326483979;4601.148787474328;4636.930446043329;4666.929996050062;4229.513605935326;4232.174725928445;4233.549657029511;4247.532771395144;4257.169851878885;5941.7920372787175;5942.138389933479;5949.732262048218;5964.671943043131;5993.430624090704;5600.719964001824;5610.326760788691;5631.352394474606;5640.689762063085;5672.546196304327;6367.554271201017;6401.935980640181;6447.774327898501;6471.158749362553;6505.583634656496;4830.9275360869615;4837.201861692852;4848.22428411456;4851.490593487703;4885.389326334208;6493;6656.8668626627195;6683.598984060924;6699.6315202663345;6700.626371593811;4908.386451693538;4921.188003979303;4961.950380496221;4964.826231081895;4971.726555039508;5045.915128247444;5046.394432668103;5057.468965758616;5060.443351231362;5068.594512438996;5496.285482887279;5519.889602207933;5599.7480113394995;5612.438756124437;5637.830865074055;6364.968175159187;6385.553011289165;6419.775307864203;6421.775237866746;6464.709088091047;1658.0963374960675;1692.5937774934173;1699.4391850689242;1749.4664127441254;1771.769669942899;1179.204037274836;1212.8302037714727;1214.4656351205442;1216.5194748074462;1217.3791366403198;6043.582566973246;6127.5404344674325;6154.723037463235;6156.07658851167;6198.2252218472695;6390.041493775971;6423.96788016057;6453.257875344396;6461.8061458156335;6578.934210657928;6205.844853878689;6207.379262073757;6268.717907694165;6285.937140628535;6310.684465776692;3424.417848965682;3425.383430982447;3427.862885484553;3429.4684323929832;3489.755717099779;6936.306369363124;6961.37347638715;6992.79021629352;6998.495323505471;7093.680784364613;6641.33586641332;6711;6721.798346049529;6725.932740672629;6743.629100399525;6904.723811047502;6986.301369862973;7002.264762199896;7027.262137475594;7093.82265443368;6387.626660268064;6472;6546.672666366568;6547.148870646785;6578.815813153678;6444.709988050643;6462.903056454063;6477.481801455967;6501.902471462838;6518.869622607616;6767;6934.202566704894;6939.306069393222;6941.501059618634;6958.874837111889;5214.217867319932;5291.60312976536;5292.655977361459;5339.78640854377;5375.81184658535;6565.540412171103;6575.50683698715;6603.735850566116;6622.470202383702;6626.83432914181;6346.587471814318;6361.77733779334;6375.968120159369;6379.555040278197;6379.840503987438;6167.475764560063;6307.211598550181;6325.588836725598;6356.2054743157105;6397.368670988868;6016.2479690038745;6214.782482613087;6217.658028808459;6302.149209856794;6308.495320374267;6345.17512723343;6347.492200623847;6372.394622510854;6376.362363763772;6381.904271435839;6017.736275382219;6076.513878889767;6198.907016394848;6222.751089956351;6232.968835155795 05:34:39 INFO - PID 14631 | |5;yui.html;931.7717159295969;943.2312665177875;943.44326874171;951.0632027452957;965.7537327981366;18150.546236344082;18899.149538270794;18966.146523406445;18990.335338263165;19610.60778784427;20338;21577.46056348588;21795.128194872184;21815.454613634665;21872;1017.0643008432241;1040.1834559870504;1042.0881728487573;1043.4626167523732;1044.7231483656838;1027.280903367642;1077.1006209814814;1081.5295346524247;1082.242430298794;1083.0144568442718;1113.6547670222217;1123.0622430270735;1123.224974767408;1123.4102096399415;1127.1152145565732;1118.0887576625066;1122.6632010396888;1124.1905827803969;1124.6850881753082;1125.8536390269294;826.1614461321764;832.4048305461564;834.56185502611;835.6740871060291;836.7615229659518;18449.815501844943;19030.714539281922;19196.328128515433;19207.231710731554;19226.80773192278;19113.713294300596;19413.22347106114;19893.900530497256;19958.10188541519;19978.100985455545;16464.259108340153;16579.585510362336;16581;16600.916995415068;16619.91690041554;3346.0798280472823;3384.424647809878;3391.4573668212965;3396.3546926083964;3398.2014226656715;139237;143397;144462;145676.2716186412;148683.25658371748;14936.47722329735;15578.766318505232;15867.603309917344;15927.442539511061;16035.759463607821;30687.846560767055;30915.227119322197;31165.220869478446;31684.841575792434;31691.524627130613;8045.275925166646;8582.656693732306;8589.484630922165;8868.8669669955;9146.95426522863;4410.360497727812;4460.286354183315;4468.798904049326;4478.977605111953;4493.73037617744;5352.143657014859;5450.3732070811575;5513.7794488220825;5891.440313170242;6091.42131497507;1151.165405081326;1174.8766379530198;1195.9940200298943;1199.898008669273;1200.699825043739;669.1234482827414;690.7962151165418;696.2932623387265;718.3427164144749;720.4272603280405;12448.564300249447;12616.747665046647;13413.39639716215;13467.393967271497;15080.472183473526;706.6466766616692;734.1153909538992;765.3418060467993;769.769069279214;784.8508783331149;5631.4087020863035;5951.553633477506;6407;6722;6779.254282028973;118683;125178;125387;126809.36595316965;132708;106301.46849265859;108803.45598271958;109834;111625;112261.43869280601;96952.99999999859;97477;97513;97656;104425.47787261166;12366.752664946831;12836.550720725103;13182.274974876475;13247.337633118499;13641.931790340985;45802;46271.76864115658;46820.531794681614;46969.765151174026;49685.25472117849;76985;79499.60250198712;80747.19252807397;81385;83015.58492207501;19627.018649067773;20212.797872021092;20289.898550507154;20300.984950752107;20464.38606841797;19192.904035479733;19295.614087718448;19648;19796.703049453983;20209;19460.610787784448;19655.70516442226;19707.605847882674;20059.799402006378;20062.49843753918;17111.7433238504;17405.738913916553;17581.648367032845;17597.472075837744;17863.017534035753;19525.51186220356;19800.722916864746;19841.20635174577;19962.900185499562;20184.394468165392;12648.620541383772;13278.867211327763;14001;14127.364268608142;14296.57110286693;13852;14128.50550230737;14279.143251404948;15512.767308490156;15737.370505179664 05:34:39 INFO - PID 14631 | __end_tp_report 05:34:39 INFO - PID 14631 | __start_cc_report 05:34:39 INFO - PID 14631 | _x_x_mozilla_cycle_collect,324 05:34:39 INFO - PID 14631 | __end_cc_report 05:34:39 INFO - PID 14631 | __startTimestamp1500726879752__endTimestamp 05:34:39 INFO - PID 14631 | 05:34:39 INFO - PID 14631 | ------- Summary: start ------- 05:34:39 INFO - PID 14631 | Number of tests: 6 05:34:39 INFO - PID 14631 | 05:34:39 INFO - PID 14631 | [#0] dojo.html Cycles:165 Average:6153.07 Median:6516.80 stddev:821.38 (12.6%) stddev-sans-first:793.91 05:34:39 INFO - PID 14631 | Values: 3349.4 3386.1 3389.4 3410.6 3459.5 5979.6 6168.8 6179.0 6179.3 6183.9 6046.4 6143.8 6149.9 6156.2 6222.6 5420.9 5421.0 5435.5 5438.1 5505.5 5120.7 5280.2 5438.2 5538.8 5542.3 5392.3 5410.5 5460.8 5469.2 5471.8 5330.9 5429.2 5471.6 5482.4 5491.2 5369.1 5376.2 5378.8 5418.5 5435.3 6091.5 6093.5 6112.0 6126.4 6173.1 6516.8 6582.2 6668.6 6711.7 6743.4 6698.7 6800.8 6804.6 6818.0 6821.7 6176.3 6193.8 6204.3 6277.6 6289.0 6706.1 6744.9 6850.0 6878.8 6932.9 6545.2 6552.3 6556.3 6565.6 6571.8 6656.8 6665.5 6730.1 6733.1 6753.3 6605.7 6630.1 6664.6 6729.6 6743.1 6578.9 6608.7 6626.8 6634.4 6714.3 4792.5 4816.7 4817.3 4830.2 4861.1 4247.2 4293.1 4319.7 4341.7 4343.1 6215.5 6251.1 6291.2 6430.7 6432.3 6603.7 6680.4 6680.9 6699.3 6708.8 6429.5 6473.8 6514.6 6524.0 6554.1 5393.4 5461.6 5467.2 5554.3 5554.9 7120.5 7238.8 7239.9 7262.4 7266.7 6682.6 6685.2 6749.1 6761.5 6775.9 6995.7 7088.2 7094.2 7129.3 7232.7 6529.8 6542.6 6548.2 6554.1 6581.4 6739.2 6743.2 6779.6 6820.2 6828.4 6526.8 6534.0 6599.4 6610.0 6622.9 6398.8 6444.0 6455.1 6521.2 6570.4 6492.2 6532.0 6569.9 6574.9 6576.7 6551.5 6564.4 6596.8 6669.1 6671.7 6304.9 6338.4 6354.3 6380.3 6407.4 05:34:39 INFO - PID 14631 | 05:34:39 INFO - PID 14631 | [#1] ext.html Cycles:180 Average:42090.75 Median:36641.50 stddev:62363.00 (170.2%) stddev-sans-first:62461.23 05:34:39 INFO - PID 14631 | Values: 894.0 910.4 921.5 957.1 958.4 43545.0 44218.0 44321.9 44410.0 44456.8 40172.8 40268.4 40446.2 40514.8 40567.8 6736.2 6841.4 6850.0 6855.0 6869.2 6731.9 6804.1 6805.6 6806.5 6823.9 6784.7 6821.2 7429.5 7601.9 7606.1 7505.4 7564.5 7566.0 7567.3 7591.0 7009.1 7377.2 7481.1 7493.7 7516.2 40335.6 40528.8 40748.8 40749.0 40850.8 3494.4 3508.9 3515.4 3525.3 3544.7 31881.2 31938.8 31977.0 32145.5 32221.2 5094.4 5113.9 5122.8 5133.3 5137.4 215563.0 215813.0 216728.0 216894.0 216929.0 52191.5 52230.0 52289.7 52295.5 52333.5 54939.0 54978.0 55020.7 55039.7 55074.4 16584.7 16895.6 16896.5 16919.3 16920.4 13673.9 13685.2 13686.7 13688.7 13693.7 15341.4 15365.2 15366.2 15402.7 15519.1 5945.6 6124.4 6132.1 6176.4 6197.8 1068.4 1077.0 1077.1 1078.4 1086.0 31378.2 31876.0 32612.0 32857.8 33544.8 1160.7 1164.7 1172.9 1174.3 1190.3 12950.5 13287.1 13435.9 13458.3 13626.5 269215.0 269369.0 269681.0 269974.0 270350.0 51558.0 51638.2 60688.7 63942.4 64109.7 1461.3 1509.6 1513.2 1527.7 1542.2 30027.5 30397.8 30631.8 30927.0 31012.5 40985.8 41485.0 41507.8 41578.0 41578.2 230585.0 230729.0 230752.0 231629.0 232152.0 37726.8 37870.8 37918.2 37944.6 38264.6 45577.0 46024.3 46385.3 46927.8 46990.5 32936.7 33012.5 34937.5 34971.0 35101.0 33574.3 34021.3 34916.7 34961.1 35195.0 35844.6 35937.8 42659.1 44004.3 44303.6 34401.0 35061.8 35951.6 36493.0 36790.0 25531.5 26393.7 27045.0 27290.0 27331.3 05:34:39 INFO - PID 14631 | 05:34:39 INFO - PID 14631 | [#2] jquery.html Cycles:180 Average:39628.35 Median:12976.22 stddev:98427.34 (758.5%) stddev-sans-first:98659.69 05:34:39 INFO - PID 14631 | Values: 534.0 553.4 555.8 558.3 590.2 22637.9 22963.8 23510.1 23525.0 23574.9 27150.5 27606.0 27678.7 27721.3 27746.7 6209.7 6262.7 6304.8 6349.3 6351.2 5784.0 6381.8 6413.3 6416.4 6419.5 6364.8 6371.3 6375.0 6385.5 6397.6 6309.1 6326.7 6338.0 6346.3 6360.9 5908.6 5915.8 5917.9 5930.2 5941.2 28512.9 30782.5 30990.5 31153.4 31241.2 2183.6 2237.4 2243.0 2244.2 2247.8 19597.2 19633.1 19747.6 19870.9 20025.7 2377.6 2438.4 2446.7 2448.1 2450.3 152355.0 154838.0 155523.0 155958.0 156284.0 15889.0 16033.4 16127.4 16136.4 16204.4 24209.0 24315.1 24383.8 24399.5 24443.3 9968.9 10542.8 10620.0 10622.6 10665.7 9172.0 9600.6 9604.4 9728.9 9829.6 9403.5 9627.5 9996.2 10010.7 10032.5 2747.0 2753.4 2784.6 2790.3 2829.0 1055.1 1066.1 1072.2 1073.8 1079.1 20554.6 21774.3 26177.5 26963.5 27331.0 1086.1 1100.7 1101.9 1125.7 1139.6 11750.7 11782.0 12309.3 12332.7 12393.7 568766.0 578589.0 588347.0 591945.0 595452.0 139103.0 140066.9 140592.3 140610.0 142318.3 1275.2 1334.5 1337.4 1356.7 1360.6 18146.4 19602.8 23054.3 24197.0 24372.1 63228.7 64780.7 64932.0 66318.7 67135.7 74076.0 74441.6 75064.6 75103.2 75185.2 14769.0 15385.5 15391.6 15415.4 15420.2 24191.9 24462.4 24860.6 24877.5 24946.9 20072.4 20321.5 20340.2 20415.2 20579.6 17498.7 17574.3 17688.6 17982.6 18817.3 19018.2 19112.1 20634.6 20813.9 20964.2 15002.4 15138.6 15248.5 15256.0 15271.7 20110.1 20147.0 20165.2 20206.3 20350.5 05:34:39 INFO - PID 14631 | 05:34:39 INFO - PID 14631 | [#3] mootools.html Cycles:180 Average:9544.33 Median:2564.99 stddev:6646.74 (259.1%) stddev-sans-first:6637.42 05:34:39 INFO - PID 14631 | Values: 1429.5 1485.2 1485.5 1497.5 1507.7 14770.6 15392.1 15484.5 15515.8 15518.3 15263.8 15745.4 15756.1 15770.8 15777.8 2682.9 2718.3 2720.1 2725.2 2730.8 2655.3 2740.3 2794.0 2794.2 2794.4 2640.9 2735.7 2776.8 2779.3 2786.3 2557.5 2572.5 2599.8 2600.1 2601.3 2583.9 2594.5 2599.9 2617.8 2631.8 14782.0 15048.5 15081.7 15091.9 15105.4 8132.2 8428.9 8452.4 8457.5 8462.3 5078.4 5239.1 5340.7 5376.4 5413.2 1862.4 1866.3 1929.5 1929.8 1949.3 25730.2 25873.9 25908.0 25926.4 25931.6 6696.7 6812.6 6830.4 7030.9 7168.4 17804.5 17937.6 17952.6 17992.0 18010.1 7782.9 7986.3 8001.6 8023.2 8026.3 6458.0 6581.3 6873.4 7218.1 7729.2 5256.8 5392.8 5431.9 5451.2 5456.2 1484.2 1509.2 1511.6 1520.5 1537.5 877.3 881.6 907.6 916.6 930.8 9789.6 9859.2 9877.3 9986.8 10264.6 1017.9 1021.1 1046.1 1062.9 1069.8 5601.6 5845.5 5888.9 5942.4 6128.1 20588.5 21427.5 21667.7 21668.5 21686.2 20859.8 21203.3 21378.7 21388.8 21413.3 10805.2 11184.8 11245.0 11331.8 11352.3 8482.7 8790.5 8905.5 9019.5 9125.6 18124.9 18580.3 18785.3 18836.4 19031.8 18858.2 18983.9 18991.2 19161.7 19762.1 12539.7 13038.2 13063.3 13067.7 13093.4 14313.6 14388.1 14464.3 14514.5 14578.4 11502.1 11552.0 11654.1 11723.2 11896.7 10809.8 10998.4 11110.2 11294.9 11558.0 9867.5 10359.9 10371.2 10414.5 10439.9 7413.7 7826.0 8014.1 8027.3 8081.1 7721.9 7738.9 7836.8 7848.5 8000.1 05:34:39 INFO - PID 14631 | 05:34:39 INFO - PID 14631 | [#4] prototype.html Cycles:180 Average:5441.80 Median:6030.66 stddev:1558.93 (25.9%) stddev-sans-first:1518.23 05:34:39 INFO - PID 14631 | Values: 483.5 491.4 522.3 523.3 532.5 5963.7 6001.3 6009.6 6010.9 6044.0 5707.5 5875.5 5897.7 5933.0 5934.1 4621.3 4638.7 4677.4 4678.2 4721.8 4553.0 4711.7 4731.3 4737.3 4743.5 4621.8 4670.4 4671.0 4674.1 4682.7 4568.2 4596.6 4601.1 4636.9 4666.9 4229.5 4232.2 4233.5 4247.5 4257.2 5941.8 5942.1 5949.7 5964.7 5993.4 5600.7 5610.3 5631.4 5640.7 5672.5 6367.6 6401.9 6447.8 6471.2 6505.6 4830.9 4837.2 4848.2 4851.5 4885.4 6493.0 6656.9 6683.6 6699.6 6700.6 4908.4 4921.2 4962.0 4964.8 4971.7 5045.9 5046.4 5057.5 5060.4 5068.6 5496.3 5519.9 5599.7 5612.4 5637.8 6365.0 6385.6 6419.8 6421.8 6464.7 1658.1 1692.6 1699.4 1749.5 1771.8 1179.2 1212.8 1214.5 1216.5 1217.4 6043.6 6127.5 6154.7 6156.1 6198.2 6390.0 6424.0 6453.3 6461.8 6578.9 6205.8 6207.4 6268.7 6285.9 6310.7 3424.4 3425.4 3427.9 3429.5 3489.8 6936.3 6961.4 6992.8 6998.5 7093.7 6641.3 6711.0 6721.8 6725.9 6743.6 6904.7 6986.3 7002.3 7027.3 7093.8 6387.6 6472.0 6546.7 6547.1 6578.8 6444.7 6462.9 6477.5 6501.9 6518.9 6767.0 6934.2 6939.3 6941.5 6958.9 5214.2 5291.6 5292.7 5339.8 5375.8 6565.5 6575.5 6603.7 6622.5 6626.8 6346.6 6361.8 6376.0 6379.6 6379.8 6167.5 6307.2 6325.6 6356.2 6397.4 6016.2 6214.8 6217.7 6302.1 6308.5 6345.2 6347.5 6372.4 6376.4 6381.9 6017.7 6076.5 6198.9 6222.8 6233.0 05:34:39 INFO - PID 14631 | 05:34:39 INFO - PID 14631 | [#5] yui.html Cycles:180 Average:26045.50 Median:19568.06 stddev:36858.26 (188.4%) stddev-sans-first:36913.42 05:34:39 INFO - PID 14631 | Values: 931.8 943.2 943.4 951.1 965.8 18150.5 18899.1 18966.1 18990.3 19610.6 20338.0 21577.5 21795.1 21815.5 21872.0 1017.1 1040.2 1042.1 1043.5 1044.7 1027.3 1077.1 1081.5 1082.2 1083.0 1113.7 1123.1 1123.2 1123.4 1127.1 1118.1 1122.7 1124.2 1124.7 1125.9 826.2 832.4 834.6 835.7 836.8 18449.8 19030.7 19196.3 19207.2 19226.8 19113.7 19413.2 19893.9 19958.1 19978.1 16464.3 16579.6 16581.0 16600.9 16619.9 3346.1 3384.4 3391.5 3396.4 3398.2 139237.0 143397.0 144462.0 145676.3 148683.3 14936.5 15578.8 15867.6 15927.4 16035.8 30687.8 30915.2 31165.2 31684.8 31691.5 8045.3 8582.7 8589.5 8868.9 9147.0 4410.4 4460.3 4468.8 4479.0 4493.7 5352.1 5450.4 5513.8 5891.4 6091.4 1151.2 1174.9 1196.0 1199.9 1200.7 669.1 690.8 696.3 718.3 720.4 12448.6 12616.7 13413.4 13467.4 15080.5 706.6 734.1 765.3 769.8 784.9 5631.4 5951.6 6407.0 6722.0 6779.3 118683.0 125178.0 125387.0 126809.4 132708.0 106301.5 108803.5 109834.0 111625.0 112261.4 96953.0 97477.0 97513.0 97656.0 104425.5 12366.8 12836.6 13182.3 13247.3 13641.9 45802.0 46271.8 46820.5 46969.8 49685.3 76985.0 79499.6 80747.2 81385.0 83015.6 19627.0 20212.8 20289.9 20301.0 20464.4 19192.9 19295.6 19648.0 19796.7 20209.0 19460.6 19655.7 19707.6 20059.8 20062.5 17111.7 17405.7 17581.6 17597.5 17863.0 19525.5 19800.7 19841.2 19962.9 20184.4 12648.6 13278.9 14001.0 14127.4 14296.6 13852.0 14128.5 14279.1 15512.8 15737.4 05:34:39 INFO - PID 14631 | -------- Summary: end -------- 05:34:39 INFO - PID 14631 | 05:34:40 INFO - TEST-INFO | 14631: exit 0 05:34:40 INFO - TEST-OK | dromaeo_css | took 1110017ms 05:34:40 INFO - TEST-START | kraken 05:34:40 INFO - Initialising browser for kraken test... 05:34:40 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44304/getInfo.html -profile /tmp/tmpeaJ6To/profile 05:34:40 INFO - TEST-INFO | started process 14998 (/builds/slave/test/build/application/firefox/firefox http://localhost:44304/getInfo.html) 05:34:46 INFO - TEST-INFO | 14998: exit 0 05:34:46 INFO - Browser initialized. 05:34:46 INFO - Running cycle 1/1 for kraken test... 05:34:46 INFO - TEST-INFO | started process 15215 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeaJ6To/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:34:57 INFO - PID 15215 | RSS: Main: 166850560 05:34:57 INFO - PID 15215 | 05:35:00 INFO - PID 15215 | Cycle 1(1): loaded http://localhost:44304/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44304/tests/kraken/driver.html?testName=audio-beat-detection) 05:35:00 INFO - PID 15215 | RSS: Main: 171257856 05:35:00 INFO - PID 15215 | 05:35:03 INFO - PID 15215 | Cycle 1(1): loaded http://localhost:44304/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44304/tests/kraken/driver.html?testName=audio-dft) 05:35:04 INFO - PID 15215 | RSS: Main: 172466176 05:35:04 INFO - PID 15215 | 05:35:07 INFO - PID 15215 | Cycle 1(1): loaded http://localhost:44304/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44304/tests/kraken/driver.html?testName=audio-fft) 05:35:07 INFO - PID 15215 | RSS: Main: 166113280 05:35:07 INFO - PID 15215 | 05:35:09 INFO - PID 15215 | Cycle 1(1): loaded http://localhost:44304/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44304/tests/kraken/driver.html?testName=audio-oscillator) 05:35:10 INFO - PID 15215 | RSS: Main: 167444480 05:35:10 INFO - PID 15215 | 05:35:12 INFO - PID 15215 | Cycle 1(1): loaded http://localhost:44304/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44304/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:35:13 INFO - PID 15215 | RSS: Main: 167124992 05:35:13 INFO - PID 15215 | 05:35:16 INFO - PID 15215 | Cycle 1(1): loaded http://localhost:44304/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44304/tests/kraken/driver.html?testName=imaging-darkroom) 05:35:16 INFO - PID 15215 | RSS: Main: 170045440 05:35:16 INFO - PID 15215 | 05:35:20 INFO - PID 15215 | Cycle 1(1): loaded http://localhost:44304/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44304/tests/kraken/driver.html?testName=imaging-desaturate) 05:35:20 INFO - PID 15215 | RSS: Main: 172228608 05:35:20 INFO - PID 15215 | 05:35:23 INFO - PID 15215 | Cycle 1(1): loaded http://localhost:44304/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44304/tests/kraken/driver.html?testName=json-parse-financial) 05:35:24 INFO - PID 15215 | RSS: Main: 170348544 05:35:24 INFO - PID 15215 | 05:35:25 INFO - PID 15215 | Cycle 1(1): loaded http://localhost:44304/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44304/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:35:26 INFO - PID 15215 | RSS: Main: 170893312 05:35:26 INFO - PID 15215 | 05:35:28 INFO - PID 15215 | Cycle 1(1): loaded http://localhost:44304/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44304/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:35:28 INFO - PID 15215 | RSS: Main: 170414080 05:35:28 INFO - PID 15215 | 05:35:30 INFO - PID 15215 | Cycle 1(1): loaded http://localhost:44304/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44304/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:35:31 INFO - PID 15215 | RSS: Main: 170291200 05:35:31 INFO - PID 15215 | 05:35:34 INFO - PID 15215 | Cycle 1(1): loaded http://localhost:44304/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44304/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:35:34 INFO - PID 15215 | RSS: Main: 170823680 05:35:34 INFO - PID 15215 | 05:35:37 INFO - PID 15215 | Cycle 1(1): loaded http://localhost:44304/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44304/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:35:38 INFO - PID 15215 | RSS: Main: 170491904 05:35:38 INFO - PID 15215 | 05:35:40 INFO - PID 15215 | Cycle 1(1): loaded http://localhost:44304/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44304/tests/kraken/driver.html?testName=ai-astar) 05:35:40 INFO - PID 15215 | RSS: Main: 171900928 05:35:40 INFO - PID 15215 | 05:35:40 INFO - PID 15215 | __start_tp_report 05:35:40 INFO - PID 15215 | _x_x_mozilla_page_load 05:35:40 INFO - PID 15215 | _x_x_mozilla_page_load_details 05:35:40 INFO - PID 15215 | |i|pagename|runs| 05:35:40 INFO - PID 15215 | |0;ai-astar;102;110;94;106;106;110;111;107;108;109 05:35:40 INFO - PID 15215 | |1;audio-beat-detection;141;117;141;169;121;152;142;114;171;116 05:35:40 INFO - PID 15215 | |2;audio-dft;162;163;162;163;163;162;162;161;163;167 05:35:40 INFO - PID 15215 | |3;audio-fft;76;75;74;167;77;77;76;75;166;76 05:35:40 INFO - PID 15215 | |4;audio-oscillator;81;85;138;83;83;81;128;80;81;142 05:35:40 INFO - PID 15215 | |5;imaging-gaussian-blur;113;114;114;114;114;113;114;114;115;114 05:35:40 INFO - PID 15215 | |6;imaging-darkroom;157;148;149;148;148;149;148;148;149;148 05:35:40 INFO - PID 15215 | |7;imaging-desaturate;94;94;94;93;94;95;95;96;94;95 05:35:40 INFO - PID 15215 | |8;json-parse-financial;47;50;47;56;46;52;47;53;48;47 05:35:40 INFO - PID 15215 | |9;json-stringify-tinderbox;54;54;54;55;54;53;55;53;54;53 05:35:40 INFO - PID 15215 | |10;stanford-crypto-aes;75;75;75;86;76;76;77;77;76;76 05:35:40 INFO - PID 15215 | |11;stanford-crypto-ccm;124;134;122;118;121;125;133;122;123;152 05:35:40 INFO - PID 15215 | |12;stanford-crypto-pbkdf2;178;169;163;166;166;183;176;170;167;161 05:35:40 INFO - PID 15215 | |13;stanford-crypto-sha256-iterative;63;64;64;65;62;61;63;65;63;62 05:35:40 INFO - PID 15215 | __end_tp_report 05:35:40 INFO - PID 15215 | __start_cc_report 05:35:40 INFO - PID 15215 | _x_x_mozilla_cycle_collect,911 05:35:40 INFO - PID 15215 | __end_cc_report 05:35:40 INFO - PID 15215 | __startTimestamp1500726940352__endTimestamp 05:35:40 INFO - PID 15215 | 05:35:40 INFO - PID 15215 | ------- Summary: start ------- 05:35:40 INFO - PID 15215 | Number of tests: 14 05:35:40 INFO - PID 15215 | 05:35:40 INFO - PID 15215 | [#0] ai-astar Cycles:10 Average:106.30 Median:109.50 stddev:5.06 (4.6%) stddev-sans-first:5.12 05:35:40 INFO - PID 15215 | Values: 102.0 110.0 94.0 106.0 106.0 110.0 111.0 107.0 108.0 109.0 05:35:40 INFO - PID 15215 | 05:35:40 INFO - PID 15215 | [#1] audio-beat-detection Cycles:10 Average:138.40 Median:141.50 stddev:21.26 (15.0%) stddev-sans-first:22.53 05:35:40 INFO - PID 15215 | Values: 141.0 117.0 141.0 169.0 121.0 152.0 142.0 114.0 171.0 116.0 05:35:40 INFO - PID 15215 | 05:35:40 INFO - PID 15215 | [#2] audio-dft Cycles:10 Average:162.80 Median:163.00 stddev:1.62 (1.0%) stddev-sans-first:1.69 05:35:40 INFO - PID 15215 | Values: 162.0 163.0 162.0 163.0 163.0 162.0 162.0 161.0 163.0 167.0 05:35:40 INFO - PID 15215 | 05:35:40 INFO - PID 15215 | [#3] audio-fft Cycles:10 Average:93.90 Median:76.00 stddev:38.28 (50.4%) stddev-sans-first:40.05 05:35:40 INFO - PID 15215 | Values: 76.0 75.0 74.0 167.0 77.0 77.0 76.0 75.0 166.0 76.0 05:35:40 INFO - PID 15215 | 05:35:40 INFO - PID 15215 | [#4] audio-oscillator Cycles:10 Average:98.20 Median:81.00 stddev:26.34 (32.5%) stddev-sans-first:27.20 05:35:40 INFO - PID 15215 | Values: 81.0 85.0 138.0 83.0 83.0 81.0 128.0 80.0 81.0 142.0 05:35:40 INFO - PID 15215 | 05:35:40 INFO - PID 15215 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 05:35:40 INFO - PID 15215 | Values: 113.0 114.0 114.0 114.0 114.0 113.0 114.0 114.0 115.0 114.0 05:35:40 INFO - PID 15215 | 05:35:40 INFO - PID 15215 | [#6] imaging-darkroom Cycles:10 Average:149.20 Median:148.50 stddev:2.78 (1.9%) stddev-sans-first:0.50 05:35:40 INFO - PID 15215 | Values: 157.0 148.0 149.0 148.0 148.0 149.0 148.0 148.0 149.0 148.0 05:35:40 INFO - PID 15215 | 05:35:40 INFO - PID 15215 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.84 (0.9%) stddev-sans-first:0.88 05:35:40 INFO - PID 15215 | Values: 94.0 94.0 94.0 93.0 94.0 95.0 95.0 96.0 94.0 95.0 05:35:40 INFO - PID 15215 | 05:35:40 INFO - PID 15215 | [#8] json-parse-financial Cycles:10 Average:49.30 Median:49.00 stddev:3.33 (6.8%) stddev-sans-first:3.43 05:35:40 INFO - PID 15215 | Values: 47.0 50.0 47.0 56.0 46.0 52.0 47.0 53.0 48.0 47.0 05:35:40 INFO - PID 15215 | 05:35:40 INFO - PID 15215 | [#9] json-stringify-tinderbox Cycles:10 Average:53.90 Median:54.00 stddev:0.74 (1.4%) stddev-sans-first:0.78 05:35:40 INFO - PID 15215 | Values: 54.0 54.0 54.0 55.0 54.0 53.0 55.0 53.0 54.0 53.0 05:35:40 INFO - PID 15215 | 05:35:40 INFO - PID 15215 | [#10] stanford-crypto-aes Cycles:10 Average:76.90 Median:76.00 stddev:3.28 (4.3%) stddev-sans-first:3.41 05:35:40 INFO - PID 15215 | Values: 75.0 75.0 75.0 86.0 76.0 76.0 77.0 77.0 76.0 76.0 05:35:40 INFO - PID 15215 | 05:35:40 INFO - PID 15215 | [#11] stanford-crypto-ccm Cycles:10 Average:127.40 Median:124.50 stddev:10.02 (8.1%) stddev-sans-first:10.56 05:35:40 INFO - PID 15215 | Values: 124.0 134.0 122.0 118.0 121.0 125.0 133.0 122.0 123.0 152.0 05:35:40 INFO - PID 15215 | 05:35:40 INFO - PID 15215 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.90 Median:169.50 stddev:7.00 (4.1%) stddev-sans-first:6.78 05:35:40 INFO - PID 15215 | Values: 178.0 169.0 163.0 166.0 166.0 183.0 176.0 170.0 167.0 161.0 05:35:40 INFO - PID 15215 | 05:35:40 INFO - PID 15215 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.50 stddev:1.32 (2.1%) stddev-sans-first:1.39 05:35:40 INFO - PID 15215 | Values: 63.0 64.0 64.0 65.0 62.0 61.0 63.0 65.0 63.0 62.0 05:35:40 INFO - PID 15215 | -------- Summary: end -------- 05:35:40 INFO - PID 15215 | 05:35:40 INFO - PID 15215 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 05:35:41 INFO - TEST-INFO | 15215: exit 0 05:35:41 INFO - TEST-OK | kraken | took 60642ms 05:35:41 INFO - SUITE-END | took 1170s 05:35:41 INFO - Completed test suite (00:19:31) 05:35:41 INFO - javascript benchmark 05:35:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8818.222358569676, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3349.4305967985424, 3386.1026827890605, 3389.4237979543477, 3410.5907291125063, 3459.481077838324, 5979.581429299951, 6168.814935551935, 6179.042248451486, 6179.289381721103, 6183.938160618398, 6046.365131661168, 6143.784967526138, 6149.877002459948, 6156.168917196188, 6222.5955312904625, 5420.891582168354, 5421.0, 5435.456454354572, 5438.075527160392, 5505.504504594585, 5120.692758434506, 5280.234366016925, 5438.15708565173, 5538.833834984957, 5542.251796007527, 5392.299001129867, 5410.5401040911765, 5460.808871689512, 5469.179623056553, 5471.781128754845, 5330.880515091835, 5429.239906413105, 5471.562275017989, 5482.424345443751, 5491.176323551459, 5369.114096174127, 5376.220448035052, 5378.838634840961, 5418.45815418455, 5435.266239057716, 6091.451769340736, 6093.512518998469, 6112.022076467788, 6126.387361263883, 6173.135760993465, 6516.804495865132, 6582.24304205013, 6668.566543174727, 6711.664416779142, 6743.426808721265, 6698.665066746692, 6800.829979250509, 6804.591724496546, 6817.965910170467, 6821.727130914757, 6176.258848938111, 6193.783217587363, 6204.286507051656, 6277.591956522857, 6288.968555157195, 6706.094677218611, 6744.865102697919, 6850.0, 6878.759243426456, 6932.896006559906, 6545.247296560861, 6552.344765523505, 6556.344365563501, 6565.573237739532, 6571.80284591463, 6656.833579160463, 6665.500087493458, 6730.091437655854, 6733.124693789874, 6753.257141714407, 6605.70274337656, 6630.071789949411, 6664.633445160563, 6729.596224226562, 6743.123393958852, 6578.901316480256, 6608.669566521655, 6626.801195964129, 6634.436072933758, 6714.294999025032, 4792.520747925179, 4816.662833601615, 4817.253325734517, 4830.203016502238, 4861.149298872683, 4247.17180149874, 4293.119910418419, 4319.67602429819, 4341.674374421931, 4343.131373725268, 6215.502759779207, 6251.12484252205, 6291.182146320949, 6430.678466076677, 6432.324605916405, 6603.7358505660195, 6680.365365290289, 6680.933190668031, 6699.263081061079, 6708.765193218214, 6429.549931504844, 6473.838154046092, 6514.609123452608, 6523.988781738838, 6554.147960765165, 5393.406725260218, 5461.590380721462, 5467.234587157801, 5554.250176226238, 5554.861128471821, 7120.537165084356, 7238.819029524198, 7239.927600723925, 7262.419006479469, 7266.745663901738, 6682.63245521501, 6685.231198412245, 6749.122614060141, 6761.459083273228, 6775.932240677727, 6995.650217489004, 7088.184858741104, 7094.184168820651, 7129.322714342129, 7232.674529646073, 6529.771457998947, 6542.607443553402, 6548.246951600627, 6554.115194448688, 6581.3747693969, 6739.191297044386, 6743.15710536183, 6779.55932864382, 6820.249772525118, 6828.351306625863, 6526.804195874131, 6533.967330163318, 6599.439047681001, 6610.041543976193, 6622.90065649006, 6398.808035758934, 6444.0, 6455.0640157176, 6521.217453905561, 6570.408663220333, 6492.188476440445, 6531.967340163269, 6569.868602628017, 6574.934250657432, 6576.671166441563, 6551.475881929529, 6564.376384243489, 6596.835079122869, 6669.0996715444735, 6671.6997735103005, 6304.936950630618, 6338.366163383809, 6354.332795056637, 6380.298167201511, 6407.359264073555], "value": 6088.133845911557, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [893.9659760689151, 910.3718434280346, 921.5484412637808, 957.1433566957569, 958.3674774648729, 43544.99999999996, 44218.0, 44321.89195270116, 44410.0, 44456.77771611138, 40172.79913600435, 40268.39597406041, 40446.19107617846, 40514.79742601283, 40567.79716101423, 6736.191657001143, 6841.350071743202, 6850.0, 6855.0, 6869.175698916137, 6731.93268067318, 6804.149481314836, 6805.625690587016, 6806.455483561328, 6823.863522729543, 6784.660766961632, 6821.215560210565, 7429.479936404454, 7601.923980760204, 7606.087269527665, 7505.399568034544, 7564.470487065908, 7566.0, 7567.281108294703, 7590.962045189794, 7009.088818453569, 7377.151627562792, 7481.102267727853, 7493.737719179857, 7516.173220945691, 40335.596644033474, 40528.797356013325, 40748.796256018824, 40749.0, 40850.79574602138, 3494.3884820156627, 3508.8947331580093, 3515.367233897897, 3525.3478106550115, 3544.6987006104514, 31881.202969925704, 31938.840305798323, 31977.0, 32145.51781723276, 32221.194470138198, 5094.363204599425, 5113.948860511385, 5122.820701275437, 5133.255677926717, 5137.357830271216, 215563.0, 215813.0, 216727.99999999843, 216894.0, 216929.0, 52191.47808521942, 52230.0, 52289.738551307, 52295.47704522982, 52333.47666523362, 54939.0, 54978.0, 55020.724896376065, 55039.724801376535, 55074.44925550693, 16584.66830663404, 16895.577610559587, 16896.493105206864, 16919.323227071025, 16920.40778572744, 13673.931630341785, 13685.178889266675, 13686.726265474834, 13688.65778355549, 13693.657658558615, 15341.386344546316, 15365.154916479702, 15366.231688415535, 15402.691946161014, 15519.1464469453, 5945.64326140433, 6124.418180272867, 6132.141500189977, 6176.363263735114, 6197.783077592263, 1068.3536460441476, 1076.9569217231224, 1077.1167642533048, 1078.369154044877, 1085.9619913302997, 31378.21554461157, 31876.0, 32612.0, 32857.83571082177, 33544.83227583847, 1160.6924165096257, 1164.6738913104343, 1172.9472173752201, 1174.3247632611283, 1190.3274649822822, 12950.546730864375, 13287.076843094505, 13435.865641343462, 13458.327083645778, 13626.523071692443, 269215.0, 269369.0, 269681.0, 269974.0, 270350.0, 51558.0, 51638.22542661863, 60688.69655651782, 63942.36057639364, 64109.67945160338, 1461.2839708542738, 1509.645233370157, 1513.2206913439588, 1527.6715506166006, 1542.2288855572215, 30027.54958675578, 30397.848010759804, 30631.846840765655, 30927.0, 31012.534811977388, 40985.795071024455, 41485.0, 41507.75476735703, 41578.0, 41578.168436631706, 230585.0, 230729.0, 230752.0, 231629.0, 232152.0, 37726.811365942995, 37870.81064594659, 37918.24163516659, 37944.620553794106, 38264.61735382611, 45577.0, 46024.30963535616, 46385.30422043739, 46927.76536117298, 46990.53009469862, 32936.67063329336, 33012.50481242831, 34937.47593786146, 34971.0, 35101.0, 33574.32851342911, 34021.31957360789, 34916.65083349236, 34961.12597184989, 35195.0, 35844.64155358413, 35937.82031089828, 42659.146817062865, 44004.33993490164, 44303.55696442995, 34401.0, 35061.82469087638, 35951.640483595875, 36493.0, 36790.0, 25531.489370212865, 26393.736062639127, 27045.0, 27290.0, 27331.31671708223], "value": 18339.45723680699, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [533.991990120148, 553.4189101443484, 555.7638003848368, 558.3439458636103, 590.2385922160413, 22637.886810565946, 22963.77036229637, 23510.059597616117, 23525.0, 23574.88212558937, 27150.45699086017, 27606.0, 27678.723212767865, 27721.30696732583, 27746.722532774667, 6209.720562574673, 6262.686865656722, 6304.842378940541, 6349.301576826545, 6351.17434733484, 5783.9710801445935, 6381.840453988641, 6413.294537600884, 6416.4225219730215, 6419.518536109787, 6364.809055728336, 6371.267304260023, 6374.968125159367, 6385.457236134911, 6397.5521713480075, 6309.08518264849, 6326.65203413812, 6338.0492926061, 6346.270178929413, 6360.9045864312075, 5908.586398952075, 5915.792947246826, 5917.881642367129, 5930.229070220844, 5941.2276404067625, 28512.857435712896, 30782.53826192609, 30990.450477476035, 31153.376932461222, 31241.218969525715, 2183.639699449589, 2237.4182712494867, 2243.013074247342, 2244.1808739810017, 2247.797698207169, 19597.21611135553, 19633.116509756954, 19747.605047899106, 19870.90064549668, 20025.699614505793, 2377.5601513720017, 2438.366024833538, 2446.7063952325834, 2448.069733501276, 2450.2894160693377, 152355.0, 154838.0, 155523.0, 155958.0, 156284.0, 15889.0, 16033.438829640907, 16127.354905803872, 16136.35454581827, 16204.43284485061, 24209.0, 24315.148969786325, 24383.7561624385, 24399.536027838385, 24443.266701998968, 9968.850467242997, 10542.841857372145, 10620.0, 10622.628208012682, 10665.680029599125, 9171.954140229389, 9600.567974441166, 9604.423734575948, 9728.902710972941, 9829.606815727291, 9403.529823508934, 9627.470489123025, 9996.150327222122, 10010.715442697388, 10032.548535315927, 2746.9725302746715, 2753.408017276295, 2784.610154578361, 2790.2560899437854, 2828.9575656365173, 1055.0978913029403, 1066.1257768629805, 1072.1690689715533, 1073.8013467508379, 1079.1151255970028, 20554.58890822175, 21774.346769596938, 26177.476450470884, 26963.460730785275, 27331.0, 1086.071408945356, 1100.658795773313, 1101.9228653994303, 1125.7241975716001, 1139.6467095200348, 11750.70623234426, 11781.997060499736, 12309.26144431337, 12332.691682707824, 12393.690157745948, 568766.0, 578589.0, 588347.0, 591945.0, 595452.0, 139103.0, 140066.8676676914, 140592.2970385162, 140610.0, 142318.2884085573, 1275.2348590845418, 1334.5395838435725, 1337.358068127285, 1356.7083077138464, 1360.6462319796924, 18146.364877229233, 19602.803971960097, 23054.308370748906, 24197.0, 24372.146974856503, 63228.68385658226, 64780.676096619216, 64932.0, 66318.66840665766, 67135.66432167808, 74076.0, 74441.6277918607, 75064.62467687845, 75103.24896751181, 75185.24814751782, 14769.0, 15385.538433847003, 15391.61520961985, 15415.383384664936, 15420.228988550753, 24191.879040604683, 24462.388440289134, 24860.62709059402, 24877.502449950538, 24946.875265623556, 20072.397828065183, 20321.49196270105, 20340.186392544725, 20415.183392664127, 20579.58840823205, 17498.73751893748, 17574.297028118734, 17688.64622707513, 17982.550436238675, 18817.341393051178, 19018.23927042903, 19112.139953701837, 20634.587308254053, 20813.89593052025, 20964.161433543097, 15002.399904003718, 15138.621534461727, 15248.466303679317, 15256.0, 15271.694566108394, 20110.095045722686, 20147.0, 20165.193392264144, 20206.29277975264, 20350.491237719176], "value": 12761.806447584006, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1429.5211104280068, 1485.2499487758673, 1485.4949317232147, 1497.4908531099425, 1507.7436835737926, 14770.556883293504, 15392.076475411483, 15484.535463936072, 15515.844841551581, 15518.30167642456, 15263.847361526381, 15745.448909288178, 15756.133412662299, 15770.763438548402, 15777.763333550007, 2682.8658567071666, 2718.293243756628, 2720.07517444069, 2725.2096891901324, 2730.754232119109, 2655.296346468178, 2740.260129764962, 2794.0360575601385, 2794.203651959182, 2794.3852352482522, 2640.9339766505896, 2735.7127501612244, 2776.763975062122, 2779.277387879146, 2786.3312804926773, 2557.488502299538, 2572.498362819251, 2599.805014623892, 2600.1289567994745, 2601.3106526770516, 2583.935401614956, 2594.507043661717, 2599.922002339933, 2617.790576753874, 2631.8420894746378, 14782.0, 15048.548543543602, 15081.698366032728, 15091.924540377227, 15105.39578416862, 8132.18678132188, 8428.873566896502, 8452.366072544522, 8457.492550446932, 8462.280706139923, 5078.4413714491375, 5239.056969745444, 5340.706261155635, 5376.38171610262, 5413.188021796723, 1862.3854128137818, 1866.2908094923978, 1929.507975466261, 1929.8263156315859, 1949.2592814730453, 25730.228093157235, 25873.870630646914, 25908.0, 25926.35184120412, 25931.611025834438, 6696.732130714717, 6812.557183783038, 6830.419414349836, 7030.894536581955, 7168.354848063699, 17804.46586602404, 17937.641247175245, 17952.551186220448, 17992.0, 18010.099495025195, 7782.922170778333, 7986.32116270112, 8001.5599142046585, 8023.1976802319305, 8026.277635012877, 6457.967710161419, 6581.2760596334365, 6873.381395674413, 7218.061651985208, 7729.227077292226, 5256.763445644955, 5392.811251606175, 5431.918521222185, 5451.209574611659, 5456.208849716848, 1484.1762821634097, 1509.222750283605, 1511.5994261520707, 1520.4602366160075, 1537.5464238049801, 877.2718643525858, 881.6164968238709, 907.5598334807613, 916.5737931861584, 930.7533503621546, 9789.559469823875, 9859.161971232526, 9877.308588398886, 9986.800263994679, 10264.589416423409, 1017.8931212222758, 1021.0912288063629, 1046.0794500839365, 1062.8990245926625, 1069.8341757027674, 5601.6358936668985, 5845.532357411482, 5888.939990801697, 5942.435468630473, 6128.050152226412, 20588.485287867625, 21427.464313391978, 21667.67498487524, 21668.45828854291, 21686.240981565887, 20859.791402085786, 21203.257885974224, 21378.679319810217, 21388.78611213899, 21413.250536231157, 10805.189610779224, 11184.832227516594, 11245.0, 11331.773364532663, 11352.318860868374, 8482.660693572188, 8790.472571645465, 8905.51019693923, 9019.458832470073, 9125.634974601207, 18124.909375453037, 18580.25678972826, 18785.34251301198, 18836.434906952814, 19031.809681903556, 18858.24567017304, 18983.905080475062, 18991.240350386382, 19161.712574311117, 19762.11070501802, 12539.74920501603, 13038.152520086163, 13063.281519516519, 13067.738645226853, 13093.410796513988, 14313.57059288223, 14388.06477578954, 14464.27678616086, 14514.491992780202, 14578.416863325772, 11502.13733969939, 11552.0, 11654.125940554663, 11723.237989530653, 11896.702582435508, 10809.837852432063, 10998.395088269903, 11110.16673749456, 11294.94352528232, 11558.0, 9867.506624668882, 10359.94820025895, 10371.222158338003, 10414.47927603632, 10439.94780026095, 7413.66638501258, 7825.960870195612, 8014.118446970712, 8027.317677997436, 8081.111077781322, 7721.884171737316, 7738.883916741141, 7836.843263134591, 7848.450608457581, 8000.119986801331], "value": 6855.962101379124, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [483.50199294726434, 491.4201242533809, 522.2505704314309, 523.3484312031517, 532.488810741688, 5963.671998040106, 6001.2896324547455, 6009.609375390602, 6010.909836352458, 6043.969780151093, 5707.543396528278, 5875.532276443893, 5897.702505448805, 5932.961731696957, 5934.109883517474, 4621.283701026337, 4638.698484598491, 4677.368555245032, 4678.181318269306, 4721.811127554911, 4553.0, 4711.740854253015, 4731.290306454042, 4737.336772851803, 4743.501932297094, 4621.79201935912, 4670.392848929651, 4671.0, 4674.083625713458, 4682.688847122794, 4568.223402021665, 4596.563326483979, 4601.148787474328, 4636.930446043329, 4666.929996050062, 4229.513605935326, 4232.174725928445, 4233.549657029511, 4247.532771395144, 4257.169851878885, 5941.7920372787175, 5942.138389933479, 5949.732262048218, 5964.671943043131, 5993.430624090704, 5600.719964001824, 5610.326760788691, 5631.352394474606, 5640.689762063085, 5672.546196304327, 6367.554271201017, 6401.935980640181, 6447.774327898501, 6471.158749362553, 6505.583634656496, 4830.9275360869615, 4837.201861692852, 4848.22428411456, 4851.490593487703, 4885.389326334208, 6493.0, 6656.8668626627195, 6683.598984060924, 6699.6315202663345, 6700.626371593811, 4908.386451693538, 4921.188003979303, 4961.950380496221, 4964.826231081895, 4971.726555039508, 5045.915128247444, 5046.394432668103, 5057.468965758616, 5060.443351231362, 5068.594512438996, 5496.285482887279, 5519.889602207933, 5599.7480113394995, 5612.438756124437, 5637.830865074055, 6364.968175159187, 6385.553011289165, 6419.775307864203, 6421.775237866746, 6464.709088091047, 1658.0963374960675, 1692.5937774934173, 1699.4391850689242, 1749.4664127441254, 1771.769669942899, 1179.204037274836, 1212.8302037714727, 1214.4656351205442, 1216.5194748074462, 1217.3791366403198, 6043.582566973246, 6127.5404344674325, 6154.723037463235, 6156.07658851167, 6198.2252218472695, 6390.041493775971, 6423.96788016057, 6453.257875344396, 6461.8061458156335, 6578.934210657928, 6205.844853878689, 6207.379262073757, 6268.717907694165, 6285.937140628535, 6310.684465776692, 3424.417848965682, 3425.383430982447, 3427.862885484553, 3429.4684323929832, 3489.755717099779, 6936.306369363124, 6961.37347638715, 6992.79021629352, 6998.495323505471, 7093.680784364613, 6641.33586641332, 6711.0, 6721.798346049529, 6725.932740672629, 6743.629100399525, 6904.723811047502, 6986.301369862973, 7002.264762199896, 7027.262137475594, 7093.82265443368, 6387.626660268064, 6472.0, 6546.672666366568, 6547.148870646785, 6578.815813153678, 6444.709988050643, 6462.903056454063, 6477.481801455967, 6501.902471462838, 6518.869622607616, 6767.0, 6934.202566704894, 6939.306069393222, 6941.501059618634, 6958.874837111889, 5214.217867319932, 5291.60312976536, 5292.655977361459, 5339.78640854377, 5375.81184658535, 6565.540412171103, 6575.50683698715, 6603.735850566116, 6622.470202383702, 6626.83432914181, 6346.587471814318, 6361.77733779334, 6375.968120159369, 6379.555040278197, 6379.840503987438, 6167.475764560063, 6307.211598550181, 6325.588836725598, 6356.2054743157105, 6397.368670988868, 6016.2479690038745, 6214.782482613087, 6217.658028808459, 6302.149209856794, 6308.495320374267, 6345.17512723343, 6347.492200623847, 6372.394622510854, 6376.362363763772, 6381.904271435839, 6017.736275382219, 6076.513878889767, 6198.907016394848, 6222.751089956351, 6232.968835155795], "value": 4984.173091686542, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [931.7717159295969, 943.2312665177875, 943.44326874171, 951.0632027452957, 965.7537327981366, 18150.546236344082, 18899.149538270794, 18966.146523406445, 18990.335338263165, 19610.60778784427, 20338.0, 21577.46056348588, 21795.128194872184, 21815.454613634665, 21872.0, 1017.0643008432241, 1040.1834559870504, 1042.0881728487573, 1043.4626167523732, 1044.7231483656838, 1027.280903367642, 1077.1006209814814, 1081.5295346524247, 1082.242430298794, 1083.0144568442718, 1113.6547670222217, 1123.0622430270735, 1123.224974767408, 1123.4102096399415, 1127.1152145565732, 1118.0887576625066, 1122.6632010396888, 1124.1905827803969, 1124.6850881753082, 1125.8536390269294, 826.1614461321764, 832.4048305461564, 834.56185502611, 835.6740871060291, 836.7615229659518, 18449.815501844943, 19030.714539281922, 19196.328128515433, 19207.231710731554, 19226.80773192278, 19113.713294300596, 19413.22347106114, 19893.900530497256, 19958.10188541519, 19978.100985455545, 16464.259108340153, 16579.585510362336, 16581.0, 16600.916995415068, 16619.91690041554, 3346.0798280472823, 3384.424647809878, 3391.4573668212965, 3396.3546926083964, 3398.2014226656715, 139237.0, 143397.0, 144462.0, 145676.2716186412, 148683.25658371748, 14936.47722329735, 15578.766318505232, 15867.603309917344, 15927.442539511061, 16035.759463607821, 30687.846560767055, 30915.227119322197, 31165.220869478446, 31684.841575792434, 31691.524627130613, 8045.275925166646, 8582.656693732306, 8589.484630922165, 8868.8669669955, 9146.95426522863, 4410.360497727812, 4460.286354183315, 4468.798904049326, 4478.977605111953, 4493.73037617744, 5352.143657014859, 5450.3732070811575, 5513.7794488220825, 5891.440313170242, 6091.42131497507, 1151.165405081326, 1174.8766379530198, 1195.9940200298943, 1199.898008669273, 1200.699825043739, 669.1234482827414, 690.7962151165418, 696.2932623387265, 718.3427164144749, 720.4272603280405, 12448.564300249447, 12616.747665046647, 13413.39639716215, 13467.393967271497, 15080.472183473526, 706.6466766616692, 734.1153909538992, 765.3418060467993, 769.769069279214, 784.8508783331149, 5631.4087020863035, 5951.553633477506, 6407.0, 6722.0, 6779.254282028973, 118683.0, 125178.0, 125387.0, 126809.36595316965, 132708.0, 106301.46849265859, 108803.45598271958, 109834.0, 111625.0, 112261.43869280601, 96952.99999999859, 97477.0, 97513.0, 97656.0, 104425.47787261166, 12366.752664946831, 12836.550720725103, 13182.274974876475, 13247.337633118499, 13641.931790340985, 45802.0, 46271.76864115658, 46820.531794681614, 46969.765151174026, 49685.25472117849, 76985.0, 79499.60250198712, 80747.19252807397, 81385.0, 83015.58492207501, 19627.018649067773, 20212.797872021092, 20289.898550507154, 20300.984950752107, 20464.38606841797, 19192.904035479733, 19295.614087718448, 19648.0, 19796.703049453983, 20209.0, 19460.610787784448, 19655.70516442226, 19707.605847882674, 20059.799402006378, 20062.49843753918, 17111.7433238504, 17405.738913916553, 17581.648367032845, 17597.472075837744, 17863.017534035753, 19525.51186220356, 19800.722916864746, 19841.20635174577, 19962.900185499562, 20184.394468165392, 12648.620541383772, 13278.867211327763, 14001.0, 14127.364268608142, 14296.57110286693, 13852.0, 14128.50550230737, 14279.143251404948, 15512.767308490156, 15737.370505179664], "value": 9656.348460204921, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1497.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 110.0, 94.0, 106.0, 106.0, 110.0, 111.0, 107.0, 108.0, 109.0], "value": 106.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 117.0, 141.0, 169.0, 121.0, 152.0, 142.0, 114.0, 171.0, 116.0], "value": 138.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 163.0, 163.0, 162.0, 162.0, 161.0, 163.0, 167.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 167.0, 77.0, 77.0, 76.0, 75.0, 166.0, 76.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 85.0, 138.0, 83.0, 83.0, 81.0, 128.0, 80.0, 81.0, 142.0], "value": 98.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 114.0, 114.0, 113.0, 114.0, 114.0, 115.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 148.0, 149.0, 148.0, 148.0, 149.0, 148.0, 148.0, 149.0, 148.0], "value": 149.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 93.0, 94.0, 95.0, 95.0, 96.0, 94.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 50.0, 47.0, 56.0, 46.0, 52.0, 47.0, 53.0, 48.0, 47.0], "value": 49.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 55.0, 54.0, 53.0, 55.0, 53.0, 54.0, 53.0], "value": 53.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 86.0, 76.0, 76.0, 77.0, 77.0, 76.0, 76.0], "value": 76.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 134.0, 122.0, 118.0, 121.0, 125.0, 133.0, 122.0, 123.0, 152.0], "value": 127.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 169.0, 163.0, 166.0, 166.0, 183.0, 176.0, 170.0, 167.0, 161.0], "value": 169.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 65.0, 62.0, 61.0, 63.0, 65.0, 63.0, 62.0], "value": 63.2, "unit": "score"}]}]} 05:35:41 INFO - Return code: 0 05:35:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:35:41 INFO - # TBPL SUCCESS # 05:35:41 INFO - Running post-action listener: _package_coverage_data 05:35:41 INFO - Running post-action listener: _resource_record_post_action 05:35:41 INFO - [mozharness: 2017-07-22 12:35:41.627754Z] Finished run-tests step (success) 05:35:41 INFO - Running post-run listener: _resource_record_post_run 05:35:41 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 435273728; Read time: 64; Write time: 267484 05:35:41 INFO - TinderboxPrint: CPU usage
13.1% 05:35:41 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 64 05:35:41 INFO - TinderboxPrint: I/O write bytes / time
435,273,728 / 267,484 05:35:41 INFO - TinderboxPrint: CPU idle
8,240.5 (86.9%) 05:35:41 INFO - TinderboxPrint: CPU user
1,191.5 (12.6%) 05:35:41 INFO - TinderboxPrint: Swap in / out
0 / 0 05:35:41 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 108576768; Read time: 0; Write time: 91700 05:35:41 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:35:41 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 326696960; Read time: 64; Write time: 175784 05:35:42 INFO - Running post-run listener: _upload_blobber_files 05:35:42 INFO - Blob upload gear active. 05:35:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:35:42 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:35:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:35:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:35:42 INFO - (blobuploader) - INFO - Open directory for files ... 05:35:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:35:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:35:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:35:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:35:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:35:46 INFO - (blobuploader) - INFO - Done attempting. 05:35:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:35:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:35:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:35:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:35:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:35:46 INFO - (blobuploader) - INFO - Done attempting. 05:35:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:35:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:35:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:35:47 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:35:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:35:47 INFO - (blobuploader) - INFO - Done attempting. 05:35:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:35:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:35:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:35:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:35:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:35:48 INFO - (blobuploader) - INFO - Done attempting. 05:35:48 INFO - (blobuploader) - INFO - Iteration through files over. 05:35:48 INFO - Return code: 0 05:35:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:35:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:35:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2924e6404288a85c8bf354cebf707bb2a83bb0a42106f3c4e232c90381b65ec4f5026c97c491bf4c85f6aa408d0c5b47e71f5caabeec64246826fb17560448d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1006787423875df45241df65b8195406ea91dafaf15d4bfaa6aac1364c32a211e2ce46ea217a66aa5cb80f3858cbcedaf75eee3e6d0434bc4eeb7d835ceefb8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36dbceb55a231e4ecaf5802c8efc94daeb6e92d2011c4840db97bbf410a1a03087ef046e4e0d04da7002c749e1dcd5e2ab6a8b9499e9ce2e4eda9a89ffba1593", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2d18790398b94bd60e757a235fba3c3436f0a7778878e7b3bb2f33d686b3d97380f0394d81b74821b17dd468d5746705234f4b425e7fcd7e839727bb713fc09b"} 05:35:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:35:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:35:48 INFO - Contents: 05:35:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2924e6404288a85c8bf354cebf707bb2a83bb0a42106f3c4e232c90381b65ec4f5026c97c491bf4c85f6aa408d0c5b47e71f5caabeec64246826fb17560448d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1006787423875df45241df65b8195406ea91dafaf15d4bfaa6aac1364c32a211e2ce46ea217a66aa5cb80f3858cbcedaf75eee3e6d0434bc4eeb7d835ceefb8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36dbceb55a231e4ecaf5802c8efc94daeb6e92d2011c4840db97bbf410a1a03087ef046e4e0d04da7002c749e1dcd5e2ab6a8b9499e9ce2e4eda9a89ffba1593", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2d18790398b94bd60e757a235fba3c3436f0a7778878e7b3bb2f33d686b3d97380f0394d81b74821b17dd468d5746705234f4b425e7fcd7e839727bb713fc09b"} 05:35:48 INFO - Running post-run listener: copy_logs_to_upload_dir 05:35:48 INFO - Copying logs to upload dir... 05:35:48 INFO - mkdir: /builds/slave/test/build/upload/logs 05:35:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.861118 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2017-07-22 05:35:47.563172) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-22 05:35:47.568389) ========= 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=51fc86400edbde9650d2781a000001d0-1500724630.712852-635091411 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/2924e6404288a85c8bf354cebf707bb2a83bb0a42106f3c4e232c90381b65ec4f5026c97c491bf4c85f6aa408d0c5b47e71f5caabeec64246826fb17560448d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1006787423875df45241df65b8195406ea91dafaf15d4bfaa6aac1364c32a211e2ce46ea217a66aa5cb80f3858cbcedaf75eee3e6d0434bc4eeb7d835ceefb8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36dbceb55a231e4ecaf5802c8efc94daeb6e92d2011c4840db97bbf410a1a03087ef046e4e0d04da7002c749e1dcd5e2ab6a8b9499e9ce2e4eda9a89ffba1593", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2d18790398b94bd60e757a235fba3c3436f0a7778878e7b3bb2f33d686b3d97380f0394d81b74821b17dd468d5746705234f4b425e7fcd7e839727bb713fc09b"} build_url:https://queue.taskcluster.net/v1/task/XJOKhumSTkeEvXj_ZHnCCQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011174 build_url: 'https://queue.taskcluster.net/v1/task/XJOKhumSTkeEvXj_ZHnCCQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2924e6404288a85c8bf354cebf707bb2a83bb0a42106f3c4e232c90381b65ec4f5026c97c491bf4c85f6aa408d0c5b47e71f5caabeec64246826fb17560448d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1006787423875df45241df65b8195406ea91dafaf15d4bfaa6aac1364c32a211e2ce46ea217a66aa5cb80f3858cbcedaf75eee3e6d0434bc4eeb7d835ceefb8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36dbceb55a231e4ecaf5802c8efc94daeb6e92d2011c4840db97bbf410a1a03087ef046e4e0d04da7002c749e1dcd5e2ab6a8b9499e9ce2e4eda9a89ffba1593", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2d18790398b94bd60e757a235fba3c3436f0a7778878e7b3bb2f33d686b3d97380f0394d81b74821b17dd468d5746705234f4b425e7fcd7e839727bb713fc09b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-22 05:35:47.596574) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 05:35:47.600040) ========= 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=51fc86400edbde9650d2781a000001d0-1500724630.712852-635091411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004507 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 05:35:47.678901) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-22 05:35:47.682238) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-22 05:35:47.682538) ========= ========= Total master_lag: 0.22 =========