builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-037 starttime: 1502360910.85 results: success (0) revision: 4d54ac07b8c97f0e6713dab2ba694023b5b2f3b5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-10 03:28:30.849668) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-10 03:28:30.850093) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-10 03:28:30.850388) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-10 03:28:30.903139) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-10 03:28:30.903496) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1502360128.715639-1924894432 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-10 03:28:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2017-08-10 03:28:31 (226 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.177574 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-10 03:28:31.134313) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-10 03:28:31.134614) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1502360128.715639-1924894432 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016849 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-10 03:28:31.196458) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-10 03:28:31.196800) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4d54ac07b8c97f0e6713dab2ba694023b5b2f3b5 --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 4d54ac07b8c97f0e6713dab2ba694023b5b2f3b5 --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=56c518bb7cbc29fb3c9463e2000001c4-1502360128.715639-1924894432 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-10 03:28:31,319 truncating revision to first 12 chars 2017-08-10 03:28:31,319 Setting DEBUG logging. 2017-08-10 03:28:31,319 attempt 1/10 2017-08-10 03:28:31,319 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4d54ac07b8c9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-10 03:28:32,499 unpacking tar archive at: mozilla-central-4d54ac07b8c9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.511763 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-10 03:28:32.725417) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-10 03:28:32.725698) ========= script_repo_revision: 4d54ac07b8c97f0e6713dab2ba694023b5b2f3b5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-10 03:28:32.726066) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-10 03:28:32.726366) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-10 03:28:32.744391) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-10 03:28:32.744746) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=56c518bb7cbc29fb3c9463e2000001c4-1502360128.715639-1924894432 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:28:33 INFO - MultiFileLogger online at 20170810 03:28:33 in /builds/slave/test 03:28:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:28:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:28:33 INFO - {'append_to_log': False, 03:28:33 INFO - 'base_work_dir': '/builds/slave/test', 03:28:33 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:28:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:28:33 INFO - 'branch': 'Firefox-Non-PGO', 03:28:33 INFO - 'buildbot_json_path': 'buildprops.json', 03:28:33 INFO - 'code_coverage': False, 03:28:33 INFO - 'config_files': ('talos/linux_config.py',), 03:28:33 INFO - 'default_actions': ('clobber', 03:28:33 INFO - 'read-buildbot-config', 03:28:33 INFO - 'download-and-extract', 03:28:33 INFO - 'populate-webroot', 03:28:33 INFO - 'create-virtualenv', 03:28:33 INFO - 'install', 03:28:33 INFO - 'setup-mitmproxy', 03:28:33 INFO - 'run-tests'), 03:28:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:28:33 INFO - 'disable_ccov_upload': False, 03:28:33 INFO - 'download_minidump_stackwalk': True, 03:28:33 INFO - 'download_symbols': 'ondemand', 03:28:33 INFO - 'enable_stylo': False, 03:28:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:28:33 INFO - 'tooltool.py': '/tools/tooltool.py', 03:28:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:28:33 INFO - '/tools/misc-python/virtualenv.py')}, 03:28:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:28:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:28:33 INFO - 'gecko_profile': False, 03:28:33 INFO - 'gecko_profile_interval': 0, 03:28:33 INFO - 'installer_path': 'installer.exe', 03:28:33 INFO - 'log_level': 'info', 03:28:33 INFO - 'log_name': 'talos', 03:28:33 INFO - 'log_to_console': True, 03:28:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:28:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:28:33 INFO - 'opt_config_files': (), 03:28:33 INFO - 'pip_index': False, 03:28:33 INFO - 'suite': 'dromaeojs-e10s', 03:28:33 INFO - 'system_bits': '32', 03:28:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:28:33 INFO - 'title': 'talos-linux64-ix-037', 03:28:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:28:33 INFO - 'use_talos_json': True, 03:28:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:28:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:28:33 INFO - 'work_dir': 'build'} 03:28:33 INFO - [mozharness: 2017-08-10 10:28:33.055251Z] Running clobber step. 03:28:33 INFO - Running pre-action listener: _resource_record_pre_action 03:28:33 INFO - Running main action method: clobber 03:28:33 INFO - rmtree: /builds/slave/test/build 03:28:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:28:34 INFO - Running post-action listener: _resource_record_post_action 03:28:34 INFO - [mozharness: 2017-08-10 10:28:34.050481Z] Finished clobber step (success) 03:28:34 INFO - [mozharness: 2017-08-10 10:28:34.050584Z] Running read-buildbot-config step. 03:28:34 INFO - Running pre-action listener: _resource_record_pre_action 03:28:34 INFO - Running main action method: read_buildbot_config 03:28:34 INFO - Using buildbot properties: 03:28:34 INFO - { 03:28:34 INFO - "project": "", 03:28:34 INFO - "product": "firefox", 03:28:34 INFO - "who": "archaeopteryx@coole-files.de", 03:28:34 INFO - "installer_path": "public/build/target.tar.bz2", 03:28:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:28:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:28:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 03:28:34 INFO - "stage_platform": "linux64", 03:28:34 INFO - "basedir": "/builds/slave/test", 03:28:34 INFO - "buildnumber": 765, 03:28:34 INFO - "platform": "ubuntu64_hw", 03:28:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:28:34 INFO - "slavebuilddir": "test", 03:28:34 INFO - "taskId": "f19og1X8SHGqrQFgayBt-Q", 03:28:34 INFO - "branch": "mozilla-central", 03:28:34 INFO - "script_repo_revision": "production", 03:28:34 INFO - "revision": "4d54ac07b8c97f0e6713dab2ba694023b5b2f3b5", 03:28:34 INFO - "slavename": "talos-linux64-ix-037", 03:28:34 INFO - "repo_path": "mozilla-central" 03:28:34 INFO - } 03:28:34 INFO - Finding installer, test and symbols from parent task. 03:28:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f19og1X8SHGqrQFgayBt-Q'}, attempt #1 03:28:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f19og1X8SHGqrQFgayBt-Q'}, attempt #1 03:28:34 INFO - Task dependencies: GaVERyTITH-z0EQo_o-6HQ 03:28:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ'}, attempt #1 03:28:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.tar.bz2 03:28:35 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.test_packages.json 03:28:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.crashreporter-symbols.zip 03:28:35 INFO - Running post-action listener: _resource_record_post_action 03:28:35 INFO - [mozharness: 2017-08-10 10:28:35.381465Z] Finished read-buildbot-config step (success) 03:28:35 INFO - [mozharness: 2017-08-10 10:28:35.381689Z] Running download-and-extract step. 03:28:35 INFO - Running pre-action listener: _resource_record_pre_action 03:28:35 INFO - Running main action method: download_and_extract 03:28:35 INFO - mkdir: /builds/slave/test/build/tests 03:28:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:35 INFO - trying https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.test_packages.json 03:28:35 INFO - Downloading https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:28:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:28:35 INFO - Downloaded 989 bytes. 03:28:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:28:35 INFO - Using the following test package requirements: 03:28:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:28:35 INFO - u'common': [u'target.common.tests.zip'], 03:28:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:28:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:28:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:28:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:28:35 INFO - u'mozbase': [u'target.common.tests.zip'], 03:28:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:28:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:28:35 INFO - u'web-platform': [u'target.common.tests.zip', 03:28:35 INFO - u'target.web-platform.tests.tar.gz'], 03:28:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:28:35 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:28:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.common.tests.zip 03:28:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:28:35 INFO - Fetch https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.common.tests.zip into memory 03:28:37 INFO - Content-Length response header: 54284018 03:28:37 INFO - Bytes received: 54284018 03:28:48 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:28:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.common.tests.zip 03:28:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:28:48 INFO - Fetch https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.common.tests.zip into memory 03:28:49 INFO - Content-Length response header: 54284018 03:28:49 INFO - Bytes received: 54284018 03:29:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.talos.tests.zip 03:29:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:29:01 INFO - Fetch https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.talos.tests.zip into memory 03:29:02 INFO - Content-Length response header: 14496008 03:29:02 INFO - Bytes received: 14496008 03:29:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:02 INFO - trying https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.tar.bz2 03:29:02 INFO - Downloading https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:29:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:29:03 INFO - Downloaded 61984427 bytes. 03:29:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.tar.bz2 03:29:03 INFO - mkdir: /builds/slave/test/properties 03:29:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:29:03 INFO - Writing to file /builds/slave/test/properties/build_url 03:29:03 INFO - Contents: 03:29:03 INFO - build_url:https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.tar.bz2 03:29:03 INFO - Running post-action listener: _resource_record_post_action 03:29:03 INFO - Running post-action listener: set_extra_try_arguments 03:29:03 INFO - [mozharness: 2017-08-10 10:29:03.820527Z] Finished download-and-extract step (success) 03:29:03 INFO - [mozharness: 2017-08-10 10:29:03.820625Z] Running populate-webroot step. 03:29:03 INFO - Running pre-action listener: _resource_record_pre_action 03:29:03 INFO - Running main action method: populate_webroot 03:29:03 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:29:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:29:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:29:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:29:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:29:03 INFO - 'tests': ['damp', 'tps']}, 03:29:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:29:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:29:03 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:29:03 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:29:03 INFO - 'other-e10s': {'tests': ['a11yr', 03:29:03 INFO - 'ts_paint', 03:29:03 INFO - 'tpaint', 03:29:03 INFO - 'sessionrestore', 03:29:03 INFO - 'sessionrestore_many_windows', 03:29:03 INFO - 'sessionrestore_no_auto_restore', 03:29:03 INFO - 'tabpaint']}, 03:29:03 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:29:03 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:29:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:29:03 INFO - 'tsvgr_opacity', 03:29:03 INFO - 'tart', 03:29:03 INFO - 'tscrollx', 03:29:03 INFO - 'tsvg_static']}, 03:29:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:29:03 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:29:03 INFO - 'talos_options': ['--mitmproxy', 03:29:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:29:03 INFO - '--firstNonBlankPaint'], 03:29:03 INFO - 'tests': ['tp6_google', 03:29:03 INFO - 'tp6_youtube', 03:29:03 INFO - 'tp6_amazon', 03:29:03 INFO - 'tp6_facebook']}, 03:29:03 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:29:03 INFO - 'talos_options': ['--stylo', 03:29:03 INFO - '--mitmproxy', 03:29:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:29:03 INFO - '--firstNonBlankPaint'], 03:29:03 INFO - 'tests': ['tp6_google', 03:29:03 INFO - 'tp6_youtube', 03:29:03 INFO - 'tp6_amazon', 03:29:03 INFO - 'tp6_facebook']}, 03:29:03 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:29:03 INFO - 'talos_options': ['--stylo', 03:29:03 INFO - '--stylo-threads=1', 03:29:03 INFO - '--mitmproxy', 03:29:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:29:03 INFO - '--firstNonBlankPaint'], 03:29:03 INFO - 'tests': ['tp6_google', 03:29:03 INFO - 'tp6_youtube', 03:29:03 INFO - 'tp6_amazon', 03:29:03 INFO - 'tp6_facebook']}, 03:29:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:29:03 INFO - 'talos_options': ['--xperf_path', 03:29:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:29:03 INFO - 'tests': ['tp5n']}}} 03:29:03 INFO - Running post-action listener: _resource_record_post_action 03:29:03 INFO - [mozharness: 2017-08-10 10:29:03.829058Z] Finished populate-webroot step (success) 03:29:03 INFO - [mozharness: 2017-08-10 10:29:03.829148Z] Running create-virtualenv step. 03:29:03 INFO - Running pre-action listener: _resource_record_pre_action 03:29:03 INFO - Running main action method: create_virtualenv 03:29:03 INFO - Creating virtualenv /builds/slave/test/build/venv 03:29:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:29:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:29:03 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:29:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:29:03 INFO - Using real prefix '/usr' 03:29:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:29:04 INFO - Installing distribute.............................................................................................................................................................................................done. 03:29:06 INFO - Installing pip.................done. 03:29:06 INFO - Return code: 0 03:29:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:29:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:29:06 INFO - Reading from file tmpfile_stdout 03:29:06 INFO - Output received: 03:29:06 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:29:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:29:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:06 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 0x24151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2783b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2786f00>, '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 0x2781ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2782050>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1502360128.715639-1924894432', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:29:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:29:06 INFO - Using env: {'DISPLAY': ':0', 03:29:06 INFO - 'HOME': '/home/cltbld', 03:29:06 INFO - 'LANG': 'en_US.UTF-8', 03:29:06 INFO - 'LANGUAGE': 'en_US:en', 03:29:06 INFO - 'LOGNAME': 'cltbld', 03:29:06 INFO - 'MAIL': '/var/mail/cltbld', 03:29:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:06 INFO - 'MOZ_NO_REMOTE': '1', 03:29:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:06 INFO - 'NO_EM_RESTART': '1', 03:29:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:06 INFO - 'PWD': '/builds/slave/test', 03:29:06 INFO - 'SHELL': '/bin/bash', 03:29:06 INFO - 'SHLVL': '1', 03:29:06 INFO - 'TERM': 'linux', 03:29:06 INFO - 'TMOUT': '86400', 03:29:06 INFO - 'USER': 'cltbld', 03:29:06 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1502360128.715639-1924894432', 03:29:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:06 INFO - '_': '/tools/buildbot/bin/python'} 03:29:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:06 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:29:06 INFO - Cleaning up... 03:29:06 INFO - Return code: 0 03:29:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:29:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:07 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 0x24151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2783b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2786f00>, '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 0x2781ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2782050>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1502360128.715639-1924894432', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:29:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:29:07 INFO - Using env: {'DISPLAY': ':0', 03:29:07 INFO - 'HOME': '/home/cltbld', 03:29:07 INFO - 'LANG': 'en_US.UTF-8', 03:29:07 INFO - 'LANGUAGE': 'en_US:en', 03:29:07 INFO - 'LOGNAME': 'cltbld', 03:29:07 INFO - 'MAIL': '/var/mail/cltbld', 03:29:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:07 INFO - 'MOZ_NO_REMOTE': '1', 03:29:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:07 INFO - 'NO_EM_RESTART': '1', 03:29:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:07 INFO - 'PWD': '/builds/slave/test', 03:29:07 INFO - 'SHELL': '/bin/bash', 03:29:07 INFO - 'SHLVL': '1', 03:29:07 INFO - 'TERM': 'linux', 03:29:07 INFO - 'TMOUT': '86400', 03:29:07 INFO - 'USER': 'cltbld', 03:29:07 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1502360128.715639-1924894432', 03:29:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:07 INFO - '_': '/tools/buildbot/bin/python'} 03:29:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:07 INFO - Downloading/unpacking psutil>=3.1.1 03:29:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:29:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:29:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:29:08 INFO - Installing collected packages: psutil 03:29:08 INFO - Running setup.py install for psutil 03:29:08 INFO - building 'psutil._psutil_linux' extension 03:29:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:29:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:29:09 INFO - building 'psutil._psutil_posix' extension 03:29:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:29:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:29:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:29:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:29:09 INFO - Successfully installed psutil 03:29:09 INFO - Cleaning up... 03:29:10 INFO - Return code: 0 03:29:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:29:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:10 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 0x24151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2783b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2786f00>, '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 0x2781ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2782050>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1502360128.715639-1924894432', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:29:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:29:10 INFO - Using env: {'DISPLAY': ':0', 03:29:10 INFO - 'HOME': '/home/cltbld', 03:29:10 INFO - 'LANG': 'en_US.UTF-8', 03:29:10 INFO - 'LANGUAGE': 'en_US:en', 03:29:10 INFO - 'LOGNAME': 'cltbld', 03:29:10 INFO - 'MAIL': '/var/mail/cltbld', 03:29:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:10 INFO - 'MOZ_NO_REMOTE': '1', 03:29:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:10 INFO - 'NO_EM_RESTART': '1', 03:29:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:10 INFO - 'PWD': '/builds/slave/test', 03:29:10 INFO - 'SHELL': '/bin/bash', 03:29:10 INFO - 'SHLVL': '1', 03:29:10 INFO - 'TERM': 'linux', 03:29:10 INFO - 'TMOUT': '86400', 03:29:10 INFO - 'USER': 'cltbld', 03:29:10 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1502360128.715639-1924894432', 03:29:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:10 INFO - '_': '/tools/buildbot/bin/python'} 03:29:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:29:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:29:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:29:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:29:11 INFO - Installing collected packages: mozsystemmonitor 03:29:11 INFO - Running setup.py install for mozsystemmonitor 03:29:11 INFO - Successfully installed mozsystemmonitor 03:29:11 INFO - Cleaning up... 03:29:11 INFO - Return code: 0 03:29:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:29:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:11 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 0x24151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2783b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2786f00>, '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 0x2781ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2782050>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1502360128.715639-1924894432', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:29:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:29:11 INFO - Using env: {'DISPLAY': ':0', 03:29:11 INFO - 'HOME': '/home/cltbld', 03:29:11 INFO - 'LANG': 'en_US.UTF-8', 03:29:11 INFO - 'LANGUAGE': 'en_US:en', 03:29:11 INFO - 'LOGNAME': 'cltbld', 03:29:11 INFO - 'MAIL': '/var/mail/cltbld', 03:29:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:11 INFO - 'MOZ_NO_REMOTE': '1', 03:29:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:11 INFO - 'NO_EM_RESTART': '1', 03:29:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:11 INFO - 'PWD': '/builds/slave/test', 03:29:11 INFO - 'SHELL': '/bin/bash', 03:29:11 INFO - 'SHLVL': '1', 03:29:11 INFO - 'TERM': 'linux', 03:29:11 INFO - 'TMOUT': '86400', 03:29:11 INFO - 'USER': 'cltbld', 03:29:11 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1502360128.715639-1924894432', 03:29:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:11 INFO - '_': '/tools/buildbot/bin/python'} 03:29:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:11 INFO - Downloading/unpacking jsonschema==2.5.1 03:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:29:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:12 INFO - Downloading functools32-3.2.3-2.tar.gz 03:29:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:29:13 INFO - warning: no files found matching '*.txt' 03:29:13 INFO - no previously-included directories found matching 'build' 03:29:13 INFO - no previously-included directories found matching 'dist' 03:29:13 INFO - no previously-included directories found matching '.git*' 03:29:13 INFO - Installing collected packages: jsonschema, functools32 03:29:13 INFO - Running setup.py install for functools32 03:29:13 INFO - warning: no files found matching '*.txt' 03:29:13 INFO - no previously-included directories found matching 'build' 03:29:13 INFO - no previously-included directories found matching 'dist' 03:29:13 INFO - no previously-included directories found matching '.git*' 03:29:13 INFO - Successfully installed jsonschema functools32 03:29:13 INFO - Cleaning up... 03:29:13 INFO - Return code: 0 03:29:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:29:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:13 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 0x24151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2783b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2786f00>, '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 0x2781ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2782050>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1502360128.715639-1924894432', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:29:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:29:13 INFO - Using env: {'DISPLAY': ':0', 03:29:13 INFO - 'HOME': '/home/cltbld', 03:29:13 INFO - 'LANG': 'en_US.UTF-8', 03:29:13 INFO - 'LANGUAGE': 'en_US:en', 03:29:13 INFO - 'LOGNAME': 'cltbld', 03:29:13 INFO - 'MAIL': '/var/mail/cltbld', 03:29:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:13 INFO - 'MOZ_NO_REMOTE': '1', 03:29:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:13 INFO - 'NO_EM_RESTART': '1', 03:29:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:13 INFO - 'PWD': '/builds/slave/test', 03:29:13 INFO - 'SHELL': '/bin/bash', 03:29:13 INFO - 'SHLVL': '1', 03:29:13 INFO - 'TERM': 'linux', 03:29:13 INFO - 'TMOUT': '86400', 03:29:13 INFO - 'USER': 'cltbld', 03:29:13 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1502360128.715639-1924894432', 03:29:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:13 INFO - '_': '/tools/buildbot/bin/python'} 03:29:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:29:13 INFO - Cleaning up... 03:29:13 INFO - Return code: 0 03:29:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:29:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:13 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 0x24151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2783b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2786f00>, '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 0x2781ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2782050>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1502360128.715639-1924894432', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:29:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:29:13 INFO - Using env: {'DISPLAY': ':0', 03:29:13 INFO - 'HOME': '/home/cltbld', 03:29:13 INFO - 'LANG': 'en_US.UTF-8', 03:29:13 INFO - 'LANGUAGE': 'en_US:en', 03:29:13 INFO - 'LOGNAME': 'cltbld', 03:29:13 INFO - 'MAIL': '/var/mail/cltbld', 03:29:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:13 INFO - 'MOZ_NO_REMOTE': '1', 03:29:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:13 INFO - 'NO_EM_RESTART': '1', 03:29:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:13 INFO - 'PWD': '/builds/slave/test', 03:29:13 INFO - 'SHELL': '/bin/bash', 03:29:13 INFO - 'SHLVL': '1', 03:29:13 INFO - 'TERM': 'linux', 03:29:13 INFO - 'TMOUT': '86400', 03:29:13 INFO - 'USER': 'cltbld', 03:29:13 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1502360128.715639-1924894432', 03:29:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:13 INFO - '_': '/tools/buildbot/bin/python'} 03:29:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:13 INFO - Downloading/unpacking blobuploader==1.2.4 03:29:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:14 INFO - Downloading blobuploader-1.2.4.tar.gz 03:29:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:29:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:29:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:29:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:15 INFO - Downloading docopt-0.6.1.tar.gz 03:29:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:29:15 INFO - Installing collected packages: blobuploader, requests, docopt 03:29:15 INFO - Running setup.py install for blobuploader 03:29:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:29:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:29:15 INFO - Running setup.py install for requests 03:29:15 INFO - Running setup.py install for docopt 03:29:15 INFO - Successfully installed blobuploader requests docopt 03:29:15 INFO - Cleaning up... 03:29:15 INFO - Return code: 0 03:29:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:29:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:15 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 0x24151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2783b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2786f00>, '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 0x2781ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2782050>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1502360128.715639-1924894432', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:29:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:29:15 INFO - Using env: {'DISPLAY': ':0', 03:29:15 INFO - 'HOME': '/home/cltbld', 03:29:15 INFO - 'LANG': 'en_US.UTF-8', 03:29:15 INFO - 'LANGUAGE': 'en_US:en', 03:29:15 INFO - 'LOGNAME': 'cltbld', 03:29:15 INFO - 'MAIL': '/var/mail/cltbld', 03:29:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:15 INFO - 'MOZ_NO_REMOTE': '1', 03:29:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:15 INFO - 'NO_EM_RESTART': '1', 03:29:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:15 INFO - 'PWD': '/builds/slave/test', 03:29:15 INFO - 'SHELL': '/bin/bash', 03:29:15 INFO - 'SHLVL': '1', 03:29:15 INFO - 'TERM': 'linux', 03:29:15 INFO - 'TMOUT': '86400', 03:29:15 INFO - 'USER': 'cltbld', 03:29:15 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1502360128.715639-1924894432', 03:29:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:15 INFO - '_': '/tools/buildbot/bin/python'} 03:29:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:29:16 INFO - Running setup.py (path:/tmp/pip-XznAJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:29:16 INFO - Running setup.py (path:/tmp/pip-MM7KVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:29:16 INFO - Running setup.py (path:/tmp/pip-oGahDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:29:16 INFO - Running setup.py (path:/tmp/pip-BnlOtc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:29:16 INFO - Running setup.py (path:/tmp/pip-uN8Qlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:29:16 INFO - Running setup.py (path:/tmp/pip-OmWPLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:29:16 INFO - Running setup.py (path:/tmp/pip-1GwgU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:29:16 INFO - Running setup.py (path:/tmp/pip-MCSgOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:29:16 INFO - Running setup.py (path:/tmp/pip-YvQAms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:29:16 INFO - Running setup.py (path:/tmp/pip-_7efy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:29:16 INFO - Running setup.py (path:/tmp/pip-fhN8st-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:29:16 INFO - Running setup.py (path:/tmp/pip-L3rPga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:29:16 INFO - Running setup.py (path:/tmp/pip-swkey2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:29:17 INFO - Running setup.py (path:/tmp/pip-FwczZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:17 INFO - Running setup.py (path:/tmp/pip-d8j3O4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:29:17 INFO - Running setup.py (path:/tmp/pip-u96UbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:29:17 INFO - Running setup.py (path:/tmp/pip-tLtL8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:29:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:29:17 INFO - Running setup.py install for manifestparser 03:29:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:29:17 INFO - Running setup.py install for mozcrash 03:29:17 INFO - Running setup.py install for mozdebug 03:29:17 INFO - Running setup.py install for mozdevice 03:29:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:29:17 INFO - Running setup.py install for mozfile 03:29:17 INFO - Running setup.py install for mozhttpd 03:29:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:29:17 INFO - Running setup.py install for mozinfo 03:29:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:29:18 INFO - Running setup.py install for mozInstall 03:29:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:29:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:29:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:29:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:29:18 INFO - Running setup.py install for mozleak 03:29:18 INFO - Running setup.py install for mozlog 03:29:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:29:18 INFO - Running setup.py install for moznetwork 03:29:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:29:18 INFO - Running setup.py install for mozprocess 03:29:18 INFO - Running setup.py install for mozprofile 03:29:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:29:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:29:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:29:18 INFO - Running setup.py install for mozrunner 03:29:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:29:18 INFO - Running setup.py install for mozscreenshot 03:29:18 INFO - Running setup.py install for moztest 03:29:19 INFO - Running setup.py install for mozversion 03:29:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:29:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:29:19 INFO - Cleaning up... 03:29:19 INFO - Return code: 0 03:29:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:29:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-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 0x24151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2783b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2786f00>, '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 0x2781ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2782050>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1502360128.715639-1924894432', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:29:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:29:19 INFO - Using env: {'DISPLAY': ':0', 03:29:19 INFO - 'HOME': '/home/cltbld', 03:29:19 INFO - 'LANG': 'en_US.UTF-8', 03:29:19 INFO - 'LANGUAGE': 'en_US:en', 03:29:19 INFO - 'LOGNAME': 'cltbld', 03:29:19 INFO - 'MAIL': '/var/mail/cltbld', 03:29:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:19 INFO - 'MOZ_NO_REMOTE': '1', 03:29:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:19 INFO - 'NO_EM_RESTART': '1', 03:29:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:19 INFO - 'PWD': '/builds/slave/test', 03:29:19 INFO - 'SHELL': '/bin/bash', 03:29:19 INFO - 'SHLVL': '1', 03:29:19 INFO - 'TERM': 'linux', 03:29:19 INFO - 'TMOUT': '86400', 03:29:19 INFO - 'USER': 'cltbld', 03:29:19 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1502360128.715639-1924894432', 03:29:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:19 INFO - '_': '/tools/buildbot/bin/python'} 03:29:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:29:19 INFO - Running setup.py (path:/tmp/pip-C5JcPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:29:19 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:29:19 INFO - Running setup.py (path:/tmp/pip-oDH0xD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:29:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:29:19 INFO - Running setup.py (path:/tmp/pip-YLRAD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:29:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:29:19 INFO - Running setup.py (path:/tmp/pip-wOEq14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:29:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:29:19 INFO - Running setup.py (path:/tmp/pip-E4h8N0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:29:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:29:19 INFO - Running setup.py (path:/tmp/pip-1YXSRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:29:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:29:19 INFO - Running setup.py (path:/tmp/pip-pMq9GA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:29:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:29:19 INFO - Running setup.py (path:/tmp/pip-yyGvKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:29:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:29:19 INFO - Running setup.py (path:/tmp/pip-Ojt75f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:29:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:29:19 INFO - Running setup.py (path:/tmp/pip-4bk_lq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:29:20 INFO - Running setup.py (path:/tmp/pip-2QbfL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:29:20 INFO - Running setup.py (path:/tmp/pip-zyWLFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:29:20 INFO - Running setup.py (path:/tmp/pip-JhbSzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:29:20 INFO - Running setup.py (path:/tmp/pip-pXo3wq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:20 INFO - Running setup.py (path:/tmp/pip-SRDvD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:29:20 INFO - Running setup.py (path:/tmp/pip-4IvFuy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:29:20 INFO - Running setup.py (path:/tmp/pip-dyUHJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:29:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:29:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:21 INFO - Downloading blessings-1.6.tar.gz 03:29:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:29:21 INFO - Installing collected packages: blessings 03:29:21 INFO - Running setup.py install for blessings 03:29:21 INFO - Successfully installed blessings 03:29:21 INFO - Cleaning up... 03:29:21 INFO - Return code: 0 03:29:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:29:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:29:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:29:22 INFO - Reading from file tmpfile_stdout 03:29:22 INFO - Current package versions: 03:29:22 INFO - argparse == 1.2.1 03:29:22 INFO - blessings == 1.6 03:29:22 INFO - blobuploader == 1.2.4 03:29:22 INFO - docopt == 0.6.1 03:29:22 INFO - functools32 == 3.2.3-2 03:29:22 INFO - jsonschema == 2.5.1 03:29:22 INFO - manifestparser == 1.1 03:29:22 INFO - mozInstall == 1.13 03:29:22 INFO - mozcrash == 1.0 03:29:22 INFO - mozdebug == 0.1 03:29:22 INFO - mozdevice == 0.51 03:29:22 INFO - mozfile == 1.2 03:29:22 INFO - mozhttpd == 0.7 03:29:22 INFO - mozinfo == 0.10 03:29:22 INFO - mozleak == 0.1 03:29:22 INFO - mozlog == 3.5 03:29:22 INFO - moznetwork == 0.27 03:29:22 INFO - mozprocess == 0.25 03:29:22 INFO - mozprofile == 0.28 03:29:22 INFO - mozrunner == 6.13 03:29:22 INFO - mozscreenshot == 0.1 03:29:22 INFO - mozsystemmonitor == 0.3 03:29:22 INFO - moztest == 0.8 03:29:22 INFO - mozversion == 1.4 03:29:22 INFO - psutil == 3.1.1 03:29:22 INFO - requests == 1.2.3 03:29:22 INFO - wsgiref == 0.1.2 03:29:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:29:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-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 0x24151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2783b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2786f00>, '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 0x2781ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2782050>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1502360128.715639-1924894432', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:29:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:29:22 INFO - Using env: {'DISPLAY': ':0', 03:29:22 INFO - 'HOME': '/home/cltbld', 03:29:22 INFO - 'LANG': 'en_US.UTF-8', 03:29:22 INFO - 'LANGUAGE': 'en_US:en', 03:29:22 INFO - 'LOGNAME': 'cltbld', 03:29:22 INFO - 'MAIL': '/var/mail/cltbld', 03:29:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:22 INFO - 'MOZ_NO_REMOTE': '1', 03:29:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:22 INFO - 'NO_EM_RESTART': '1', 03:29:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:22 INFO - 'PWD': '/builds/slave/test', 03:29:22 INFO - 'SHELL': '/bin/bash', 03:29:22 INFO - 'SHLVL': '1', 03:29:22 INFO - 'TERM': 'linux', 03:29:22 INFO - 'TMOUT': '86400', 03:29:22 INFO - 'USER': 'cltbld', 03:29:22 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1502360128.715639-1924894432', 03:29:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:22 INFO - '_': '/tools/buildbot/bin/python'} 03:29:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:29:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:29:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:29:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:29:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:29:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:29:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:29:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:29:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:29:22 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:29:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:29:23 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:29:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:29:23 INFO - Installing collected packages: simplejson 03:29:23 INFO - Running setup.py install for simplejson 03:29:23 INFO - building 'simplejson._speedups' extension 03:29:23 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 03:29:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:29:24 INFO - Successfully installed simplejson 03:29:24 INFO - Cleaning up... 03:29:24 INFO - Return code: 0 03:29:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:29:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2783b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2786f00>, '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 0x2781ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2782050>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1502360128.715639-1924894432', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:29:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:29:24 INFO - Using env: {'DISPLAY': ':0', 03:29:24 INFO - 'HOME': '/home/cltbld', 03:29:24 INFO - 'LANG': 'en_US.UTF-8', 03:29:24 INFO - 'LANGUAGE': 'en_US:en', 03:29:24 INFO - 'LOGNAME': 'cltbld', 03:29:24 INFO - 'MAIL': '/var/mail/cltbld', 03:29:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:24 INFO - 'MOZ_NO_REMOTE': '1', 03:29:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:24 INFO - 'NO_EM_RESTART': '1', 03:29:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:24 INFO - 'PWD': '/builds/slave/test', 03:29:24 INFO - 'SHELL': '/bin/bash', 03:29:24 INFO - 'SHLVL': '1', 03:29:24 INFO - 'TERM': 'linux', 03:29:24 INFO - 'TMOUT': '86400', 03:29:24 INFO - 'USER': 'cltbld', 03:29:24 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1502360128.715639-1924894432', 03:29:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:24 INFO - '_': '/tools/buildbot/bin/python'} 03:29:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:29:24 INFO - Cleaning up... 03:29:24 INFO - Return code: 0 03:29:24 INFO - Running post-action listener: _resource_record_post_action 03:29:24 INFO - Running post-action listener: _start_resource_monitoring 03:29:24 INFO - Starting resource monitoring. 03:29:24 INFO - [mozharness: 2017-08-10 10:29:24.870067Z] Finished create-virtualenv step (success) 03:29:24 INFO - [mozharness: 2017-08-10 10:29:24.871101Z] Running install step. 03:29:24 INFO - Running pre-action listener: _resource_record_pre_action 03:29:24 INFO - Running main action method: install 03:29:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:29:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:29:25 INFO - Reading from file tmpfile_stdout 03:29:25 INFO - Detecting whether we're running mozinstall >=1.0... 03:29:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:29:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:29:25 INFO - Reading from file tmpfile_stdout 03:29:25 INFO - Output received: 03:29:25 INFO - Usage: mozinstall [options] installer 03:29:25 INFO - Options: 03:29:25 INFO - -h, --help show this help message and exit 03:29:25 INFO - -d DEST, --destination=DEST 03:29:25 INFO - Directory to install application into. [default: 03:29:25 INFO - "/builds/slave/test"] 03:29:25 INFO - --app=APP Application being installed. [default: firefox] 03:29:25 INFO - mkdir: /builds/slave/test/build/application 03:29:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:29:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:29:43 INFO - Reading from file tmpfile_stdout 03:29:43 INFO - Output received: 03:29:43 INFO - /builds/slave/test/build/application/firefox/firefox 03:29:43 INFO - Running post-action listener: _resource_record_post_action 03:29:43 INFO - [mozharness: 2017-08-10 10:29:43.180715Z] Finished install step (success) 03:29:43 INFO - [mozharness: 2017-08-10 10:29:43.180863Z] Running setup-mitmproxy step. 03:29:43 INFO - Running pre-action listener: _resource_record_pre_action 03:29:43 INFO - Running main action method: setup_mitmproxy 03:29:43 INFO - Skipping: mitmproxy is not required 03:29:43 INFO - Running post-action listener: _resource_record_post_action 03:29:43 INFO - [mozharness: 2017-08-10 10:29:43.181447Z] Finished setup-mitmproxy step (success) 03:29:43 INFO - [mozharness: 2017-08-10 10:29:43.181677Z] Running run-tests step. 03:29:43 INFO - Running pre-action listener: _resource_record_pre_action 03:29:43 INFO - Running pre-action listener: _set_gcov_prefix 03:29:43 INFO - Running main action method: run_tests 03:29:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:29:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:29:43 INFO - Python 2.7.3 03:29:43 INFO - Return code: 0 03:29:43 INFO - grabbing minidump binary from tooltool 03:29:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:43 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 0x2786f00>, '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 0x2781ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2782050>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:29:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:29:43 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:29:43 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:29:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:29:43 INFO - Return code: 0 03:29:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:29:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:29:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:29:43 INFO - ENV: RUST_BACKTRACE is now full 03:29:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:29:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:29:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:29:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-037 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:29:43 INFO - Using env: {'DISPLAY': ':0', 03:29:43 INFO - 'HOME': '/home/cltbld', 03:29:43 INFO - 'LANG': 'en_US.UTF-8', 03:29:43 INFO - 'LANGUAGE': 'en_US:en', 03:29:43 INFO - 'LOGNAME': 'cltbld', 03:29:43 INFO - 'MAIL': '/var/mail/cltbld', 03:29:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:29:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:29:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:43 INFO - 'MOZ_NO_REMOTE': '1', 03:29:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:29:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:43 INFO - 'NO_EM_RESTART': '1', 03:29:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:43 INFO - 'PWD': '/builds/slave/test', 03:29:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:29:43 INFO - 'RUST_BACKTRACE': 'full', 03:29:43 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:29:43 INFO - 'SHELL': '/bin/bash', 03:29:43 INFO - 'SHLVL': '1', 03:29:43 INFO - 'TERM': 'linux', 03:29:43 INFO - 'TMOUT': '86400', 03:29:43 INFO - 'USER': 'cltbld', 03:29:43 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1502360128.715639-1924894432', 03:29:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:43 INFO - '_': '/tools/buildbot/bin/python'} 03:29:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:29:43 INFO - mozversion application_buildid: 20170810094558 03:29:43 INFO - mozversion application_changeset: 4d54ac07b8c97f0e6713dab2ba694023b5b2f3b5 03:29:43 INFO - mozversion application_display_name: Nightly 03:29:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:29:43 INFO - mozversion application_name: Firefox 03:29:43 INFO - mozversion application_remotingname: firefox 03:29:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:29:43 INFO - mozversion application_vendor: Mozilla 03:29:43 INFO - mozversion application_version: 57.0a1 03:29:43 INFO - mozversion platform_buildid: 20170810094558 03:29:43 INFO - mozversion platform_changeset: 4d54ac07b8c97f0e6713dab2ba694023b5b2f3b5 03:29:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:29:43 INFO - mozversion platform_version: 57.0a1 03:29:43 INFO - using testdate: 1502360983 03:29:43 INFO - actual date: 1502360983 03:29:43 INFO - starting webserver on 'localhost:50724' 03:29:43 INFO - SUITE-START | Running 2 tests 03:29:43 INFO - TEST-START | dromaeo_css 03:29:43 INFO - Initialising browser for dromaeo_css test... 03:29:43 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50724/getInfo.html -profile /tmp/tmp3Gj5ZP/profile 03:29:43 INFO - TEST-INFO | started process 3344 (/builds/slave/test/build/application/firefox/firefox http://localhost:50724/getInfo.html) 03:29:51 INFO - TEST-INFO | 3344: exit 0 03:29:51 INFO - Browser initialized. 03:29:51 INFO - Running cycle 1/1 for dromaeo_css test... 03:29:51 INFO - TEST-INFO | started process 3552 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3Gj5ZP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:29:52 INFO - PID 3552 | 03:29:52 INFO - PID 3552 | (/builds/slave/test/build/application/firefox/firefox:3600): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:29:52 INFO - PID 3552 | 03:30:02 INFO - PID 3552 | RSS: Main: 171769856 03:30:02 INFO - PID 3552 | 03:33:02 INFO - PID 3552 | Cycle 1(1): loaded http://localhost:50724/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50724/tests/dromaeo/cssquery-ext.html) 03:33:04 INFO - PID 3552 | RSS: Main: 173604864 03:33:04 INFO - PID 3552 | 03:36:05 INFO - PID 3552 | Cycle 1(1): loaded http://localhost:50724/tests/dromaeo/cssquery-ext.html (next: http://localhost:50724/tests/dromaeo/cssquery-jquery.html) 03:36:06 INFO - PID 3552 | RSS: Main: 170889216 03:36:06 INFO - PID 3552 | 03:39:08 INFO - PID 3552 | Cycle 1(1): loaded http://localhost:50724/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50724/tests/dromaeo/cssquery-mootools.html) 03:39:08 INFO - PID 3552 | RSS: Main: 172711936 03:39:08 INFO - PID 3552 | 03:42:10 INFO - PID 3552 | Cycle 1(1): loaded http://localhost:50724/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50724/tests/dromaeo/cssquery-prototype.html) 03:42:11 INFO - PID 3552 | RSS: Main: 171216896 03:42:11 INFO - PID 3552 | 03:45:14 INFO - PID 3552 | Cycle 1(1): loaded http://localhost:50724/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50724/tests/dromaeo/cssquery-yui.html) 03:45:15 INFO - PID 3552 | RSS: Main: 174710784 03:45:15 INFO - PID 3552 | 03:48:17 INFO - PID 3552 | Cycle 1(1): loaded http://localhost:50724/tests/dromaeo/cssquery-yui.html (next: http://localhost:50724/tests/dromaeo/cssquery-dojo.html) 03:48:17 INFO - PID 3552 | RSS: Main: 175521792 03:48:17 INFO - PID 3552 | 03:48:17 INFO - PID 3552 | __start_tp_report 03:48:17 INFO - PID 3552 | _x_x_mozilla_page_load 03:48:17 INFO - PID 3552 | _x_x_mozilla_page_load_details 03:48:17 INFO - PID 3552 | |i|pagename|runs| 03:48:17 INFO - PID 3552 | |0;dojo.html;3103.92240193995;3142.1673256586996;3159.4155081309955;3198.216436972941;3216.1477208539727;6205.162303089081;6236.781712640059;6249.875002499947;6287.842803929904;6392.55252132351;6276.1527193828815;6335.904961425582;6368.872622547547;6382.489400847932;6406.487481001509;5700.287464066992;5755;5768.451997060293;5853.32686741026;5876.7355469004;5679.829605111853;5722.656640601556;5763.250777398932;5766.884662306772;5855.121731740252;5736.4550367715;5798.536117110642;5803.73883175256;5810.912836307459;5812;5729.28383952006;5761.683107429089;5819.0689489681445;5821.796237131723;5829.09649004405;5594.552435805166;5644.379118296984;5689.7439615217;5737.799177028784;5755.884882302373;6204.937950620481;6210.285817131043;6235.438810507076;6243.157173781527;6270.498360131179;6757.898631520531;6788.355106264897;6829.078074459983;6829.795106146824;6834.282400347991;6789.219239787389;6790.728370865159;6810.523263371566;6891.655417229119;6899.206591241971;6223.813285601439;6260.248770147566;6291.842703932347;6355.110284560165;6377.426031657127;6947.444204463631;6952;6962.303769622998;6969.407600353925;6971.860562788817;6513.348665133543;6611.73553057882;6639.203295604461;6640.169978752656;6644.900326495106;6730.293319201512;6748;6750.291219421988;6751.426128779109;6752.459803215731;6694.397504224643;6704.597724136567;6746.460283177334;6801.829954251084;6815.250322464525;6789.966050169717;6793.830154246183;6869.450443964571;6885;6889.483288753364;5357.973210134002;5448.673079615236;5507.834764957058;5514.972425137848;5521.282233309644;4646.581807637329;4651.325557794101;4702.694324868872;4716.386869706985;4739.454962679267;5915.349311575723;5921.7631294747725;5930.28836539618;5932.169496270526;5947.672877991666;6730.663466826639;6793.558418702769;6845.14435695538;6847;6903.482238832108;5724.427557244242;5840.123981402823;5885.764569417261;5964.075568286922;5969.582129250911;5960.284765828128;5960.552958528041;5964.582479226413;5972.283326000821;5980.923433781874;6534.117894084333;6537.509686773511;6645.102911107036;6653.201615806038;6655.401013908771;6734.925370151184;6849.931500684929;6875.965620171867;6886.208086070166;6899.310068993061;6502.089707441057;6591.538592298493;6627.271000190071;6628.204615446178;6637.734490620321;6639.3692599203;6649.700763465559;6663.500237482305;6737.663116844236;6752.831179220559;6698.866022679422;6817.5568588041615;6818.897716534355;6850.691718872563;6883.518153729191;6557.639329836714;6566.277709452052;6574.76988305407;6579.440747536321;6586.571872828251;6548.3124271952665;6557.96721016411;6569.9343006569325;6600.042993765973;6609.20689517261;5640.802571910128;6338.809835704937;6414.10202571631;6415.967920160369;6434.292227855026;6441.903371449525;6452.290248072614;6479.449246814073;6551.6069035858;6575.506836987341;6343.5876668016435;6347.650879201688;6424.678766061772;6426.742930282736;6454.644994525346 03:48:17 INFO - PID 3552 | |1;ext.html;773.3967505345829;851.506126446661;880.616931634739;882.6072397782989;1187.7861984842725;29420.264493387676;30267.394652106974;40940.59059409409;41368;41531;41763;42048.57951420485;42123.57876421235;42287.365689514685;42333.15333693325;7239.457040721941;7650.808729781745;7798.142204357516;7801.453898227126;7806.80482987927;7631.732889348874;7743.10954240264;7747.186545412735;7748;7756.689732410697;7761.728339508119;7788.14330423653;7790;7822.217778222161;7827.491213071161;7707.229277072276;7795.5712435816295;7813.101493328283;7818.218178182193;7822.491538050009;7638.809029774245;7663.425243106789;7712.884306735404;7714.228577142297;7717.7298794542485;38857.805710971545;39014.414783778266;39030.414543781866;39051;39146.21707565861;3545.06055895188;3575.856965721368;3576.998440436682;3581.301646178996;3589.425691889285;31366.843165784252;31443.842780785948;31519.84240078808;31540.211494712585;31712.414379280945;5000.699958002531;5054.898902021939;5082.288479612857;5103.744812759384;5112.182050871843;188590;189600.0519997405;191000;191668;192078.03960980245;49010.75494622504;49104.7544762281;49446.50553494491;49604.50395495999;49831.501684983414;50991;50991.235131473055;51179;51189.232161517604;51245.74377128165;14126.646833829236;14243.43026278958;14248.643783905485;14301.57095287143;14346.21095839718;10288.382697038052;10412.531436085394;11504.194706370641;11518.424078796026;11521.942390287995;14275.928620356832;14312.427502899976;14408.207548584718;14452.988290819541;14506.637334066732;5787.942120578825;5849.415058494116;5893.587448878623;5895.263092113486;5903.203067585821;999.9350042247231;1013.6553571785628;1015.3755440404099;1017.811704834608;1029.325791606499;22977.425564361023;23740.762592373856;23834.165804197117;23913;23957.640635390482;1084.4306738962107;1087.8694556653095;1099.230538622967;1101.1576144249655;1120.1263014848432;11904.702382440508;12301.815472767916;12386.442610082568;12436;12446.81329780054;236075;236896;238638;238662;238755;55147.72426137843;55155.17267240994;55448.44551554433;55501.16748248779;55556.16665750017;1426.1514398932618;1452.3319273134266;1455.2360010994312;1459.299536222619;1473.2265560580781;22461.775382245967;22724.318270451913;22845.657315139953;22856.428589285402;23066.654000190345;37349.25301493901;37663;37789.43315850209;37798.24403511969;37814.62185378111;210088;210394;213992;214553;215389;35103.47344789779;35353;35394.8230258847;36912.81543592372;38229.61770382261;45832.7708361456;47441.76279118582;47713.04573908572;47787.76106119447;47932.28101578549;35062;35568.82215588906;35772.46341304934;35776.28447431089;36556.45165322469;34739.826300868335;34837.65162348445;34840.30319393649;35053.29893402169;35121;38029;38078.47686092525;38112.23775524418;38213.42679859749;38421.807890961485;33560.66439335673;33734;33822.49266261057;33894.32211355808;34028.65971340255;24739;25641.871790640926;25709.35726606775;26166;26490.602640960016 03:48:17 INFO - PID 3552 | |2;jquery.html;569.0042425754926;570.3213176320179;577.4946921443736;587.4976894754984;588.5703436491361;21661.45846353842;22444.3266701999;22511;22560.435989100282;24402.511949760996;25928.74071259287;26524.20427387177;26528.469430611378;26596.867015664895;26612.73387266127;6387.265464471587;6559.9672001640165;6565.34346565342;6571.112899758543;6572.277049524549;5912;6426.357364263583;6454.612723236597;6462.063000864871;6487.351264873522;6397.296297407282;6406.935930640704;6407.8398040048905;6407.9359206408035;6414.871702565946;6393.552451328409;6401.743930242785;6404.871902561946;6412.422881940624;6418.326075762071;5950.791722289742;5968;5980.372060933626;5994.340622531518;5998.880022399528;29162.270943226376;30148.54777178344;30329.241768955733;30470.390592188254;31004.22489437782;1976.545394559245;2004.2383894120287;2009.4875806669352;2014.0231987486059;2018.3541266794632;18101.4569562912;19202.711959320623;20112.899435502728;20204.595908081905;20281.188752449885;2391.964120538193;2434.6226334918115;2456.8157388195777;2461.778439940396;2530.835495692774;147761;149383;151639.24180379137;152162;160405.19797401055;14905.925470372578;15204.847951520343;15537.611559711098;15589.376424943102;15656.37374505007;23517.882410587838;23836.64245036326;23868;23901.521969560512;23924.7607523926;9070.410423322463;9212.585433655502;9243.815123697623;9319.813603727887;9691.224702023821;8376.790580235422;8410.873836892451;8416.452930559493;8422.53676047811;8431.451955622864;8857.247133993555;9235.769105772275;9297.535123243946;9502.619895204252;9504.144626983605;2639.788816894644;2692.7576518113465;2700.8649567521547;2717.3885875677815;2776.3753155539844;945.262695097811;964.0889359555154;978.9853152202722;979.397670432693;979.8285300072458;19431;19488.902555487133;19718;20152.29466968649;20205.898970505346;1030.721705139608;1038.8389799580925;1041.109851077318;1047.984280235797;1052.9157667386592;10937.890621093846;11050.834237486444;11132.666020019413;11195.104391648649;11195.552177912956;495250;508279;512785;518614;518729;118842;121429;122199;128234;130477;1233.8951189148843;1267.8351814264086;1302.5766625846447;1302.8501722302058;1309.6987692830703;21127.788722113197;21212.681809772555;21456.678149827454;21525.677114842976;21558.568828623655;57745.422545774;58276.125858111314;58413;59943.40056599378;61108.69445652743;70978;71523;71830.64084679753;71886.28113719005;72703.27296726964;12649.810252846031;14792.556223313319;15376.154311512973;15407.84592154109;22099.889500552395;24518.264452066465;24836.627450587894;25361.746382535937;25424.237272881845;25651.615225772002;18774.624507510045;19032.809671903105;19524.804751952866;19556.706649399985;19727.11227994715;17247.56881077983;17422.73865892038;17681.204345804726;17775.46673599794;17998.460046198634;19413.32053378125;19872.60254794925;19940;20036.799632003494;20055.59888802245;21265.787342126998;21344.679829802255;21417.393695473213;21555.353339399844;21599.35201943944;18363.908180459013;18601;19047.23811047598;19812.405627831187;19914 03:48:17 INFO - PID 3552 | |3;mootools.html;1376.3393571085878;1429.821272340958;1432.1120905038874;1432.792245124457;1441.5819412370413;13594.252316122609;14074.155550666954;14135.717285654293;14247.216403097826;14260.144391336502;13719.108257963251;14098.083624564397;14636.536346365358;14642.853571464282;14677.412903483875;2638.0898589986423;2711.4712631036955;2715.3618899558587;2716.4838680650714;2728.6589176352954;2588.0424243030106;2647.7881769458495;2656.2296933889147;2692.3269182704325;2693.178580532937;2208.712867327245;2291.46150654596;2649.562822134355;2749.4363655450584;2749.8212616179985;2719.7008329083783;2735.466584016118;2735.5623100303956;2736.4390299988454;2736.58951157326;2589.7151313355516;2623.265485664017;2660.521106200883;2674.0640775728534;2674.638923745289;13863.098898571561;14089.577312680636;14104.224267665275;14146.787798183035;14148;7556.962215188943;7793.220677932218;7820.865974433732;7863.764087077339;7880.487768295043;5017.272495488134;5173.482651734834;5315.282436871012;5325.121354976424;5328.413874473805;1873.7470441490361;1899.420676693608;1927.816857398559;1974.861759676823;1985.0967809646577;22961.42596435086;23194.3041708749;23212.53574928509;23239;23278.06887724506;6577.901331480031;6621.9337806621315;6635.469162466991;6695.598264104169;6733.293004234485;16117.516474505783;16119.194040297938;16180.271887765079;16219.27013284405;16241.91879040621;7392.223816499298;7500;7508.549487030796;7510.061242344707;7511.812204694927;6727.159105111861;6878.449724022066;7124.964375178195;7139.357457828821;7172.282771722786;5043.445221025684;5170.586353091744;5173.120569503193;5173.379194496684;5174.301469301596;1405.620482469748;1407.479232683893;1407.8310602727533;1423.0465588056027;1424.7364237615866;868.9044205137429;895.3866601378077;903.7559858838077;905.6965916417942;907.587047893207;7245.731996900521;7283.781486555412;7313.707451701873;7362.226966168475;7366.484346095722;675.4461341699857;964.0841200859072;992.4888682328607;993.6621548673486;1004.1163775877181;5069.898602027939;5077.873053173626;5131.461196574381;5249.976254630386;5306.708131052752;18914.243430262635;19167.712484312746;19703.211871524978;20097;20102.69845952312;19226.423207303804;19285.61428771445;19375.806241937684;19430;19456.221751129797;10251.231157663206;10399.584016639401;10702.09032232269;10710.357378557312;10854.728631784268;8471.110533393905;8534.871976920227;8535.3598480113;8540.786480337792;8558.52928088961;15875.52373428799;16698;16702;16768.916155419145;17076.402325918534;16573.751393728864;16600.418985335455;16645.0845203515;16963.83036169672;17010.659786803946;11660.591879284184;11940.402979851146;11956.641300760992;11957.940210298893;11978.880211198126;12444.440000199831;12531.812022819848;12769.553065642658;12804.61586152417;13312.201267923956;10356.637517686844;10458.215633827645;10550;10587.682369528926;10630.468476575985;10320.535575898952;10467.476626168509;10470.476476176009;10603.310784798963;10660;8566.400351975302;8674.306055515417;8682.652693892427;8706;8712.99800522948;6640.966795165993;6668.533202675766;6680.565763225375;6719.731210751515;6764.661766911733;6913.1358580177475;7081.8937715935335;7112.786616401516;7186.281371862772;7254.093238345207 03:48:17 INFO - PID 3552 | |4;prototype.html;498.19491009216114;502.2537025112686;519.5661622545175;523.0350004242176;524.8609118583573;6212.316645169028;6246.437820596146;6266.561340706153;6276.1527193828815;6278.121063051177;5818.41815818419;5985.760569577212;6004.159417681528;6071.848203794907;6101;4937.827176048839;4965.577925876287;4966.9751651241695;4975.651704380694;4993.350864387625;4746.098241334153;4952.851414457554;4954.900901981958;4958;5007.84976450707;4857.785553611597;4870.878228044309;4892.119418504668;4900.705957642535;4931.5068493150575;4807.591354734816;4845.3216549683075;4860.076585448754;4879.024195160982;4909.705417674951;4418.4093726258525;4420.403245561873;4423.469183697976;4447.110577884436;4482.8879278017985;5944.970275148597;5946.464818166386;5955.434233747787;5998.130271110708;6019.518438524908;5608.411116832755;5615.241942337773;5644.830655080313;5648.604597678164;5679.914801277942;6383.744650213986;6395.232572091332;6457.83855403614;6495.6752162391695;6520.4457621102265;4805.687630304019;4853.126437241295;4861.586765124968;4901.005680370522;4930.309756634074;6787.592744435349;6825.146856642919;6840.521163518605;6841.8026845302375;6856.965715171442;4939.6542242042715;4980.626453016038;4980.77586508608;4983.127952608279;5038.193888977819;5010.749462526859;5080.212567052113;5107.719075450812;5112.676760105886;5124.795008199705;5582.134769110794;5664.971675141598;5681.375048744635;5700.6009579329875;5700.800471983461;6405.814924239031;6412.3267056959285;6448;6458.804006637765;6519.608823470607;1635.337688236266;1685.6965746165808;1710.2902295547458;1719.733441316573;1745.4152858792447;1215.3194211241732;1215.6231568213882;1234.6913271682079;1242.726600147966;1243.881831226032;5639;5644.520215781705;5721.256236689203;5750.424957504216;5759.798407055733;6528.804135875931;6584.176977877765;6605.4055135037115;6644.534882558271;6670.39966403026;5667.328138199241;5730.34101078373;5734.369219385864;5739.713014349266;5748.540116790647;3530.6822385985383;3547.1841476460045;3576.302620988882;3576.766015724571;3592.2995015972156;6481.902771458432;6515.566575353415;6547.181602299713;6560.573562718408;6588.24235212947;6911.619860907598;6923.9653801730665;6938.27148149437;6944.340287672663;6961.13656920414;6458.060583044339;6488.902666460007;6532.314107018885;6569.704363303663;6572.375624315682;6622.271550129578;6643.534952553468;6648.700808463534;6712.194536655633;6742.460603151638;6575.868482630416;6602.372774586406;6651.900221496585;6660.700268487833;6666.933330666825;6339.714712838026;6361.8727625448155;6447.6131432114225;6467.514936379885;6542.34576542361;4956.231784073474;5009.21988296499;5009.499050094962;5013.323201367769;5023.196288593807;6801.149856267966;6814.2163651180745;6814.93185068143;6823.577629941497;6838.179418469816;6363;6440.871182576416;6482.157319548429;6489.805305840832;6519.8044058678315;6128.754849805958;6326.4622507087415;6357.682115894279;6457.321981191907;6464.935350646433;6272.560920735687;6349.68251587428;6377.681115944277;6406.5515413920575;6435.485161187187;6536.3136870627895;6548.443382312366;6563.212414510289;6580.177477815273;6586.70359833799;6292.716827742671;6293.992961126198;6322.652254126067;6326.462250708557;6390.7763228286785 03:48:17 INFO - PID 3552 | |5;yui.html;913.5432283858071;918.4994178172897;935.5556110847344;938.9201917836988;939.3002213351052;17389.217485213198;18613.7207941881;19535.804641953575;19604.607907841833;19696.11367488463;15565.221738913066;18520.722189167172;18529.629407411845;18597.721034184466;18616.25534978599;1026.2251999740204;1049.574922156528;1050.406520316019;1052.0741747262437;1052.8104941110596;1025.4308858583483;1058.5871510111062;1061.517009760561;1063.2025980514613;1066.221658189522;1108.2962318927498;1128.4978184707809;1129.1080046763047;1129.824877144044;1130.1015692524463;1118.7706520163347;1130.8869113088667;1131.0894729742554;1131.4003578103618;1132.1508868348737;815.2825513548099;816.9264766171013;819.9385046121565;822.6627082895984;822.8354329134137;19492.512687182792;19682.606347873105;19751.80248197514;19869.30457433983;20695.68956465639;20205.696914546294;20460.897695511576;21807.80057096859;22145.00347484367;22360.32919012432;18146.818531814777;19171.424857254304;19187.52031199217;19271.90364048171;19309.61380772391;3605.2248766515063;3612.3858943979585;3615.837287322077;3618.240169564395;3630.782153070798;122733;123183;124922;125154.37422812919;127688;17258;17949;18064.36774712879;18240;18257.269709211483;32421;32439.675603243664;32812;33051.66948330534;33397.16507087342;8704.78238044054;8904;8983.910160898438;8989.55052247385;9048.954755226181;4114.485689288839;4180.665546756252;4183.6653067754505;4195.748255104703;4223.260929337353;5001.624878134155;5231.29377534028;5244.239585260116;5425.620206585501;5848.3274423441;1152.6599653102355;1174.7533018066301;1176.2942234659306;1178.6169494914186;1179.33367647279;662.2351184381951;673.2358772792916;675.1965161457849;677.2459330334359;697.5396238482679;11957.461914213882;12254.448549815279;12531.43608537618;12980.896623786895;13365.26491043002;652.6051738698114;681.1213534540387;720.330093013492;725.9237780033126;733.9522931009467;5494.313210848644;5679.545636349082;5737.598368114275;5905.586608937333;5940.34656187819;108996;110808.44595777131;111223.44388278006;112979;113591.43204284091;95548;98477;98645.50677246568;99669.00330996598;102909;83178.16821831826;86654.56672716723;89308;89536.55231723799;89613;12878.420471078636;13308.600741977756;13381.53164639233;13438;13513;38506.422403664525;39619;41388.379174311805;42171.57828421799;43831.34252986144;82015.58992205001;82162.58918705369;83899.5805020971;84888.57555712182;85824.14175858161;19325.226990920204;19438.31965881244;19561.608767824848;19731.90134049378;20550.38348849537;22077.116915323208;22153.446163846034;22310.442238944157;22342.994565244928;22594;18511.90744046271;18679.346222882134;18864.434066978014;19584.412467625993;19938.30215942493;18592;20478.385648430572;20572.588548228654;20607.690884636442;20737.170513179302;16958.660826783642;17187.398441055004;17958;18313.267469301078;18383.54041148982;14315.713685726436;14793;14943.925280373529;14949.626259343604;15053.6989260212;14529.85470145285;14562.854371456573;14951.252437378305;15059.774103388678;15848.92075539661 03:48:17 INFO - PID 3552 | __end_tp_report 03:48:17 INFO - PID 3552 | __start_cc_report 03:48:17 INFO - PID 3552 | _x_x_mozilla_cycle_collect,354 03:48:17 INFO - PID 3552 | __end_cc_report 03:48:17 INFO - PID 3552 | __startTimestamp1502362097570__endTimestamp 03:48:17 INFO - PID 3552 | 03:48:17 INFO - PID 3552 | ------- Summary: start ------- 03:48:17 INFO - PID 3552 | Number of tests: 6 03:48:17 INFO - PID 3552 | 03:48:17 INFO - PID 3552 | [#0] dojo.html Cycles:165 Average:6221.68 Median:6426.74 stddev:743.16 (11.6%) stddev-sans-first:704.04 03:48:17 INFO - PID 3552 | Values: 3103.9 3142.2 3159.4 3198.2 3216.1 6205.2 6236.8 6249.9 6287.8 6392.6 6276.2 6335.9 6368.9 6382.5 6406.5 5700.3 5755.0 5768.5 5853.3 5876.7 5679.8 5722.7 5763.3 5766.9 5855.1 5736.5 5798.5 5803.7 5810.9 5812.0 5729.3 5761.7 5819.1 5821.8 5829.1 5594.6 5644.4 5689.7 5737.8 5755.9 6204.9 6210.3 6235.4 6243.2 6270.5 6757.9 6788.4 6829.1 6829.8 6834.3 6789.2 6790.7 6810.5 6891.7 6899.2 6223.8 6260.2 6291.8 6355.1 6377.4 6947.4 6952.0 6962.3 6969.4 6971.9 6513.3 6611.7 6639.2 6640.2 6644.9 6730.3 6748.0 6750.3 6751.4 6752.5 6694.4 6704.6 6746.5 6801.8 6815.3 6790.0 6793.8 6869.5 6885.0 6889.5 5358.0 5448.7 5507.8 5515.0 5521.3 4646.6 4651.3 4702.7 4716.4 4739.5 5915.3 5921.8 5930.3 5932.2 5947.7 6730.7 6793.6 6845.1 6847.0 6903.5 5724.4 5840.1 5885.8 5964.1 5969.6 5960.3 5960.6 5964.6 5972.3 5980.9 6534.1 6537.5 6645.1 6653.2 6655.4 6734.9 6849.9 6876.0 6886.2 6899.3 6502.1 6591.5 6627.3 6628.2 6637.7 6639.4 6649.7 6663.5 6737.7 6752.8 6698.9 6817.6 6818.9 6850.7 6883.5 6557.6 6566.3 6574.8 6579.4 6586.6 6548.3 6558.0 6569.9 6600.0 6609.2 5640.8 6338.8 6414.1 6416.0 6434.3 6441.9 6452.3 6479.4 6551.6 6575.5 6343.6 6347.7 6424.7 6426.7 6454.6 03:48:17 INFO - PID 3552 | 03:48:17 INFO - PID 3552 | [#1] ext.html Cycles:180 Average:38673.52 Median:35774.37 stddev:55688.04 (155.7%) stddev-sans-first:55771.54 03:48:17 INFO - PID 3552 | Values: 773.4 851.5 880.6 882.6 1187.8 29420.3 30267.4 40940.6 41368.0 41531.0 41763.0 42048.6 42123.6 42287.4 42333.2 7239.5 7650.8 7798.1 7801.5 7806.8 7631.7 7743.1 7747.2 7748.0 7756.7 7761.7 7788.1 7790.0 7822.2 7827.5 7707.2 7795.6 7813.1 7818.2 7822.5 7638.8 7663.4 7712.9 7714.2 7717.7 38857.8 39014.4 39030.4 39051.0 39146.2 3545.1 3575.9 3577.0 3581.3 3589.4 31366.8 31443.8 31519.8 31540.2 31712.4 5000.7 5054.9 5082.3 5103.7 5112.2 188590.0 189600.1 191000.0 191668.0 192078.0 49010.8 49104.8 49446.5 49604.5 49831.5 50991.0 50991.2 51179.0 51189.2 51245.7 14126.6 14243.4 14248.6 14301.6 14346.2 10288.4 10412.5 11504.2 11518.4 11521.9 14275.9 14312.4 14408.2 14453.0 14506.6 5787.9 5849.4 5893.6 5895.3 5903.2 999.9 1013.7 1015.4 1017.8 1029.3 22977.4 23740.8 23834.2 23913.0 23957.6 1084.4 1087.9 1099.2 1101.2 1120.1 11904.7 12301.8 12386.4 12436.0 12446.8 236075.0 236896.0 238638.0 238662.0 238755.0 55147.7 55155.2 55448.4 55501.2 55556.2 1426.2 1452.3 1455.2 1459.3 1473.2 22461.8 22724.3 22845.7 22856.4 23066.7 37349.3 37663.0 37789.4 37798.2 37814.6 210088.0 210394.0 213992.0 214553.0 215389.0 35103.5 35353.0 35394.8 36912.8 38229.6 45832.8 47441.8 47713.0 47787.8 47932.3 35062.0 35568.8 35772.5 35776.3 36556.5 34739.8 34837.7 34840.3 35053.3 35121.0 38029.0 38078.5 38112.2 38213.4 38421.8 33560.7 33734.0 33822.5 33894.3 34028.7 24739.0 25641.9 25709.4 26166.0 26490.6 03:48:17 INFO - PID 3552 | 03:48:17 INFO - PID 3552 | [#2] jquery.html Cycles:180 Average:36579.78 Median:13418.57 stddev:86460.42 (644.3%) stddev-sans-first:86660.69 03:48:17 INFO - PID 3552 | Values: 569.0 570.3 577.5 587.5 588.6 21661.5 22444.3 22511.0 22560.4 24402.5 25928.7 26524.2 26528.5 26596.9 26612.7 6387.3 6560.0 6565.3 6571.1 6572.3 5912.0 6426.4 6454.6 6462.1 6487.4 6397.3 6406.9 6407.8 6407.9 6414.9 6393.6 6401.7 6404.9 6412.4 6418.3 5950.8 5968.0 5980.4 5994.3 5998.9 29162.3 30148.5 30329.2 30470.4 31004.2 1976.5 2004.2 2009.5 2014.0 2018.4 18101.5 19202.7 20112.9 20204.6 20281.2 2392.0 2434.6 2456.8 2461.8 2530.8 147761.0 149383.0 151639.2 152162.0 160405.2 14905.9 15204.8 15537.6 15589.4 15656.4 23517.9 23836.6 23868.0 23901.5 23924.8 9070.4 9212.6 9243.8 9319.8 9691.2 8376.8 8410.9 8416.5 8422.5 8431.5 8857.2 9235.8 9297.5 9502.6 9504.1 2639.8 2692.8 2700.9 2717.4 2776.4 945.3 964.1 979.0 979.4 979.8 19431.0 19488.9 19718.0 20152.3 20205.9 1030.7 1038.8 1041.1 1048.0 1052.9 10937.9 11050.8 11132.7 11195.1 11195.6 495250.0 508279.0 512785.0 518614.0 518729.0 118842.0 121429.0 122199.0 128234.0 130477.0 1233.9 1267.8 1302.6 1302.9 1309.7 21127.8 21212.7 21456.7 21525.7 21558.6 57745.4 58276.1 58413.0 59943.4 61108.7 70978.0 71523.0 71830.6 71886.3 72703.3 12649.8 14792.6 15376.2 15407.8 22099.9 24518.3 24836.6 25361.7 25424.2 25651.6 18774.6 19032.8 19524.8 19556.7 19727.1 17247.6 17422.7 17681.2 17775.5 17998.5 19413.3 19872.6 19940.0 20036.8 20055.6 21265.8 21344.7 21417.4 21555.4 21599.4 18363.9 18601.0 19047.2 19812.4 19914.0 03:48:17 INFO - PID 3552 | 03:48:17 INFO - PID 3552 | [#3] mootools.html Cycles:180 Average:8697.12 Median:2630.68 stddev:5942.09 (225.9%) stddev-sans-first:5933.30 03:48:17 INFO - PID 3552 | Values: 1376.3 1429.8 1432.1 1432.8 1441.6 13594.3 14074.2 14135.7 14247.2 14260.1 13719.1 14098.1 14636.5 14642.9 14677.4 2638.1 2711.5 2715.4 2716.5 2728.7 2588.0 2647.8 2656.2 2692.3 2693.2 2208.7 2291.5 2649.6 2749.4 2749.8 2719.7 2735.5 2735.6 2736.4 2736.6 2589.7 2623.3 2660.5 2674.1 2674.6 13863.1 14089.6 14104.2 14146.8 14148.0 7557.0 7793.2 7820.9 7863.8 7880.5 5017.3 5173.5 5315.3 5325.1 5328.4 1873.7 1899.4 1927.8 1974.9 1985.1 22961.4 23194.3 23212.5 23239.0 23278.1 6577.9 6621.9 6635.5 6695.6 6733.3 16117.5 16119.2 16180.3 16219.3 16241.9 7392.2 7500.0 7508.5 7510.1 7511.8 6727.2 6878.4 7125.0 7139.4 7172.3 5043.4 5170.6 5173.1 5173.4 5174.3 1405.6 1407.5 1407.8 1423.0 1424.7 868.9 895.4 903.8 905.7 907.6 7245.7 7283.8 7313.7 7362.2 7366.5 675.4 964.1 992.5 993.7 1004.1 5069.9 5077.9 5131.5 5250.0 5306.7 18914.2 19167.7 19703.2 20097.0 20102.7 19226.4 19285.6 19375.8 19430.0 19456.2 10251.2 10399.6 10702.1 10710.4 10854.7 8471.1 8534.9 8535.4 8540.8 8558.5 15875.5 16698.0 16702.0 16768.9 17076.4 16573.8 16600.4 16645.1 16963.8 17010.7 11660.6 11940.4 11956.6 11957.9 11978.9 12444.4 12531.8 12769.6 12804.6 13312.2 10356.6 10458.2 10550.0 10587.7 10630.5 10320.5 10467.5 10470.5 10603.3 10660.0 8566.4 8674.3 8682.7 8706.0 8713.0 6641.0 6668.5 6680.6 6719.7 6764.7 6913.1 7081.9 7112.8 7186.3 7254.1 03:48:17 INFO - PID 3552 | 03:48:17 INFO - PID 3552 | [#4] prototype.html Cycles:180 Average:5470.69 Median:6001.14 stddev:1536.97 (25.6%) stddev-sans-first:1495.28 03:48:17 INFO - PID 3552 | Values: 498.2 502.3 519.6 523.0 524.9 6212.3 6246.4 6266.6 6276.2 6278.1 5818.4 5985.8 6004.2 6071.8 6101.0 4937.8 4965.6 4967.0 4975.7 4993.4 4746.1 4952.9 4954.9 4958.0 5007.8 4857.8 4870.9 4892.1 4900.7 4931.5 4807.6 4845.3 4860.1 4879.0 4909.7 4418.4 4420.4 4423.5 4447.1 4482.9 5945.0 5946.5 5955.4 5998.1 6019.5 5608.4 5615.2 5644.8 5648.6 5679.9 6383.7 6395.2 6457.8 6495.7 6520.4 4805.7 4853.1 4861.6 4901.0 4930.3 6787.6 6825.1 6840.5 6841.8 6857.0 4939.7 4980.6 4980.8 4983.1 5038.2 5010.7 5080.2 5107.7 5112.7 5124.8 5582.1 5665.0 5681.4 5700.6 5700.8 6405.8 6412.3 6448.0 6458.8 6519.6 1635.3 1685.7 1710.3 1719.7 1745.4 1215.3 1215.6 1234.7 1242.7 1243.9 5639.0 5644.5 5721.3 5750.4 5759.8 6528.8 6584.2 6605.4 6644.5 6670.4 5667.3 5730.3 5734.4 5739.7 5748.5 3530.7 3547.2 3576.3 3576.8 3592.3 6481.9 6515.6 6547.2 6560.6 6588.2 6911.6 6924.0 6938.3 6944.3 6961.1 6458.1 6488.9 6532.3 6569.7 6572.4 6622.3 6643.5 6648.7 6712.2 6742.5 6575.9 6602.4 6651.9 6660.7 6666.9 6339.7 6361.9 6447.6 6467.5 6542.3 4956.2 5009.2 5009.5 5013.3 5023.2 6801.1 6814.2 6814.9 6823.6 6838.2 6363.0 6440.9 6482.2 6489.8 6519.8 6128.8 6326.5 6357.7 6457.3 6464.9 6272.6 6349.7 6377.7 6406.6 6435.5 6536.3 6548.4 6563.2 6580.2 6586.7 6292.7 6294.0 6322.7 6326.5 6390.8 03:48:17 INFO - PID 3552 | 03:48:17 INFO - PID 3552 | [#5] yui.html Cycles:180 Average:24642.85 Median:19714.01 stddev:32834.55 (166.6%) stddev-sans-first:32878.31 03:48:17 INFO - PID 3552 | Values: 913.5 918.5 935.6 938.9 939.3 17389.2 18613.7 19535.8 19604.6 19696.1 15565.2 18520.7 18529.6 18597.7 18616.3 1026.2 1049.6 1050.4 1052.1 1052.8 1025.4 1058.6 1061.5 1063.2 1066.2 1108.3 1128.5 1129.1 1129.8 1130.1 1118.8 1130.9 1131.1 1131.4 1132.2 815.3 816.9 819.9 822.7 822.8 19492.5 19682.6 19751.8 19869.3 20695.7 20205.7 20460.9 21807.8 22145.0 22360.3 18146.8 19171.4 19187.5 19271.9 19309.6 3605.2 3612.4 3615.8 3618.2 3630.8 122733.0 123183.0 124922.0 125154.4 127688.0 17258.0 17949.0 18064.4 18240.0 18257.3 32421.0 32439.7 32812.0 33051.7 33397.2 8704.8 8904.0 8983.9 8989.6 9049.0 4114.5 4180.7 4183.7 4195.7 4223.3 5001.6 5231.3 5244.2 5425.6 5848.3 1152.7 1174.8 1176.3 1178.6 1179.3 662.2 673.2 675.2 677.2 697.5 11957.5 12254.4 12531.4 12980.9 13365.3 652.6 681.1 720.3 725.9 734.0 5494.3 5679.5 5737.6 5905.6 5940.3 108996.0 110808.4 111223.4 112979.0 113591.4 95548.0 98477.0 98645.5 99669.0 102909.0 83178.2 86654.6 89308.0 89536.6 89613.0 12878.4 13308.6 13381.5 13438.0 13513.0 38506.4 39619.0 41388.4 42171.6 43831.3 82015.6 82162.6 83899.6 84888.6 85824.1 19325.2 19438.3 19561.6 19731.9 20550.4 22077.1 22153.4 22310.4 22343.0 22594.0 18511.9 18679.3 18864.4 19584.4 19938.3 18592.0 20478.4 20572.6 20607.7 20737.2 16958.7 17187.4 17958.0 18313.3 18383.5 14315.7 14793.0 14943.9 14949.6 15053.7 14529.9 14562.9 14951.3 15059.8 15848.9 03:48:17 INFO - PID 3552 | -------- Summary: end -------- 03:48:17 INFO - PID 3552 | 03:48:18 INFO - TEST-INFO | 3552: exit 0 03:48:18 INFO - TEST-OK | dromaeo_css | took 1114403ms 03:48:18 INFO - TEST-START | kraken 03:48:18 INFO - Initialising browser for kraken test... 03:48:18 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50724/getInfo.html -profile /tmp/tmpi8QolE/profile 03:48:18 INFO - TEST-INFO | started process 3915 (/builds/slave/test/build/application/firefox/firefox http://localhost:50724/getInfo.html) 03:48:23 INFO - TEST-INFO | 3915: exit 0 03:48:23 INFO - Browser initialized. 03:48:23 INFO - Running cycle 1/1 for kraken test... 03:48:23 INFO - TEST-INFO | started process 4124 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi8QolE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:48:24 INFO - PID 4124 | 03:48:24 INFO - PID 4124 | (/builds/slave/test/build/application/firefox/firefox:4173): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:48:24 INFO - PID 4124 | 03:48:34 INFO - PID 4124 | RSS: Main: 168370176 03:48:34 INFO - PID 4124 | 03:48:37 INFO - PID 4124 | Cycle 1(1): loaded http://localhost:50724/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50724/tests/kraken/driver.html?testName=audio-beat-detection) 03:48:38 INFO - PID 4124 | RSS: Main: 172826624 03:48:38 INFO - PID 4124 | 03:48:40 INFO - PID 4124 | Cycle 1(1): loaded http://localhost:50724/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50724/tests/kraken/driver.html?testName=audio-dft) 03:48:41 INFO - PID 4124 | RSS: Main: 173481984 03:48:41 INFO - PID 4124 | 03:48:44 INFO - PID 4124 | Cycle 1(1): loaded http://localhost:50724/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50724/tests/kraken/driver.html?testName=audio-fft) 03:48:45 INFO - PID 4124 | RSS: Main: 167931904 03:48:45 INFO - PID 4124 | 03:48:47 INFO - PID 4124 | Cycle 1(1): loaded http://localhost:50724/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50724/tests/kraken/driver.html?testName=audio-oscillator) 03:48:47 INFO - PID 4124 | RSS: Main: 168751104 03:48:47 INFO - PID 4124 | 03:48:50 INFO - PID 4124 | Cycle 1(1): loaded http://localhost:50724/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50724/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:48:50 INFO - PID 4124 | RSS: Main: 168943616 03:48:50 INFO - PID 4124 | 03:48:53 INFO - PID 4124 | Cycle 1(1): loaded http://localhost:50724/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50724/tests/kraken/driver.html?testName=imaging-darkroom) 03:48:54 INFO - PID 4124 | RSS: Main: 171974656 03:48:54 INFO - PID 4124 | 03:48:57 INFO - PID 4124 | Cycle 1(1): loaded http://localhost:50724/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50724/tests/kraken/driver.html?testName=imaging-desaturate) 03:48:58 INFO - PID 4124 | RSS: Main: 172007424 03:48:58 INFO - PID 4124 | 03:49:01 INFO - PID 4124 | Cycle 1(1): loaded http://localhost:50724/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50724/tests/kraken/driver.html?testName=json-parse-financial) 03:49:01 INFO - PID 4124 | RSS: Main: 171991040 03:49:01 INFO - PID 4124 | 03:49:03 INFO - PID 4124 | Cycle 1(1): loaded http://localhost:50724/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50724/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:49:04 INFO - PID 4124 | RSS: Main: 171814912 03:49:04 INFO - PID 4124 | 03:49:05 INFO - PID 4124 | Cycle 1(1): loaded http://localhost:50724/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50724/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:49:06 INFO - PID 4124 | RSS: Main: 171864064 03:49:06 INFO - PID 4124 | 03:49:08 INFO - PID 4124 | Cycle 1(1): loaded http://localhost:50724/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50724/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:49:09 INFO - PID 4124 | RSS: Main: 171716608 03:49:09 INFO - PID 4124 | 03:49:12 INFO - PID 4124 | Cycle 1(1): loaded http://localhost:50724/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50724/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:49:12 INFO - PID 4124 | RSS: Main: 172105728 03:49:12 INFO - PID 4124 | 03:49:15 INFO - PID 4124 | Cycle 1(1): loaded http://localhost:50724/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50724/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:49:16 INFO - PID 4124 | RSS: Main: 172552192 03:49:16 INFO - PID 4124 | 03:49:18 INFO - PID 4124 | Cycle 1(1): loaded http://localhost:50724/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50724/tests/kraken/driver.html?testName=ai-astar) 03:49:18 INFO - PID 4124 | RSS: Main: 173867008 03:49:18 INFO - PID 4124 | 03:49:18 INFO - PID 4124 | __start_tp_report 03:49:18 INFO - PID 4124 | _x_x_mozilla_page_load 03:49:18 INFO - PID 4124 | _x_x_mozilla_page_load_details 03:49:18 INFO - PID 4124 | |i|pagename|runs| 03:49:18 INFO - PID 4124 | |0;ai-astar;99;107;101;107;106;110;108;98;108;109 03:49:18 INFO - PID 4124 | |1;audio-beat-detection;146;122;147;174;125;145;146;117;165;119 03:49:18 INFO - PID 4124 | |2;audio-dft;164;163;162;164;164;164;162;163;171;172 03:49:18 INFO - PID 4124 | |3;audio-fft;74;76;75;172;75;74;74;88;97;76 03:49:18 INFO - PID 4124 | |4;audio-oscillator;78;79;138;80;80;79;131;78;78;125 03:49:18 INFO - PID 4124 | |5;imaging-gaussian-blur;113;115;114;114;114;114;114;114;114;113 03:49:18 INFO - PID 4124 | |6;imaging-darkroom;151;150;151;150;150;151;150;152;152;149 03:49:18 INFO - PID 4124 | |7;imaging-desaturate;95;94;94;94;94;95;94;94;94;94 03:49:18 INFO - PID 4124 | |8;json-parse-financial;55;55;56;55;55;56;56;55;54;55 03:49:18 INFO - PID 4124 | |9;json-stringify-tinderbox;54;54;54;55;53;54;53;54;53;54 03:49:18 INFO - PID 4124 | |10;stanford-crypto-aes;78;89;78;79;79;77;78;87;93;78 03:49:18 INFO - PID 4124 | |11;stanford-crypto-ccm;139;131;128;126;133;128;128;143;130;161 03:49:18 INFO - PID 4124 | |12;stanford-crypto-pbkdf2;179;183;176;171;176;192;176;169;171;174 03:49:18 INFO - PID 4124 | |13;stanford-crypto-sha256-iterative;76;66;65;68;64;65;68;67;71;70 03:49:18 INFO - PID 4124 | __end_tp_report 03:49:18 INFO - PID 4124 | __start_cc_report 03:49:18 INFO - PID 4124 | _x_x_mozilla_cycle_collect,957 03:49:18 INFO - PID 4124 | __end_cc_report 03:49:18 INFO - PID 4124 | __startTimestamp1502362158529__endTimestamp 03:49:18 INFO - PID 4124 | 03:49:18 INFO - PID 4124 | ------- Summary: start ------- 03:49:18 INFO - PID 4124 | Number of tests: 14 03:49:18 INFO - PID 4124 | 03:49:18 INFO - PID 4124 | [#0] ai-astar Cycles:10 Average:105.30 Median:108.50 stddev:4.32 (4.0%) stddev-sans-first:3.94 03:49:18 INFO - PID 4124 | Values: 99.0 107.0 101.0 107.0 106.0 110.0 108.0 98.0 108.0 109.0 03:49:18 INFO - PID 4124 | 03:49:18 INFO - PID 4124 | [#1] audio-beat-detection Cycles:10 Average:140.60 Median:146.00 stddev:19.56 (13.4%) stddev-sans-first:20.65 03:49:18 INFO - PID 4124 | Values: 146.0 122.0 147.0 174.0 125.0 145.0 146.0 117.0 165.0 119.0 03:49:18 INFO - PID 4124 | 03:49:18 INFO - PID 4124 | [#2] audio-dft Cycles:10 Average:164.90 Median:164.00 stddev:3.57 (2.2%) stddev-sans-first:3.77 03:49:18 INFO - PID 4124 | Values: 164.0 163.0 162.0 164.0 164.0 164.0 162.0 163.0 171.0 172.0 03:49:18 INFO - PID 4124 | 03:49:18 INFO - PID 4124 | [#3] audio-fft Cycles:10 Average:88.10 Median:75.50 stddev:30.46 (40.3%) stddev-sans-first:31.88 03:49:18 INFO - PID 4124 | Values: 74.0 76.0 75.0 172.0 75.0 74.0 74.0 88.0 97.0 76.0 03:49:18 INFO - PID 4124 | 03:49:18 INFO - PID 4124 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:78.50 stddev:25.54 (32.5%) stddev-sans-first:26.38 03:49:18 INFO - PID 4124 | Values: 78.0 79.0 138.0 80.0 80.0 79.0 131.0 78.0 78.0 125.0 03:49:18 INFO - PID 4124 | 03:49:18 INFO - PID 4124 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 03:49:18 INFO - PID 4124 | Values: 113.0 115.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 113.0 03:49:18 INFO - PID 4124 | 03:49:18 INFO - PID 4124 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:151.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 03:49:18 INFO - PID 4124 | Values: 151.0 150.0 151.0 150.0 150.0 151.0 150.0 152.0 152.0 149.0 03:49:18 INFO - PID 4124 | 03:49:18 INFO - PID 4124 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 03:49:18 INFO - PID 4124 | Values: 95.0 94.0 94.0 94.0 94.0 95.0 94.0 94.0 94.0 94.0 03:49:18 INFO - PID 4124 | 03:49:18 INFO - PID 4124 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 03:49:18 INFO - PID 4124 | Values: 55.0 55.0 56.0 55.0 55.0 56.0 56.0 55.0 54.0 55.0 03:49:18 INFO - PID 4124 | 03:49:18 INFO - PID 4124 | [#9] json-stringify-tinderbox Cycles:10 Average:53.80 Median:54.00 stddev:0.63 (1.2%) stddev-sans-first:0.67 03:49:18 INFO - PID 4124 | Values: 54.0 54.0 54.0 55.0 53.0 54.0 53.0 54.0 53.0 54.0 03:49:18 INFO - PID 4124 | 03:49:18 INFO - PID 4124 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:79.00 stddev:5.78 (7.3%) stddev-sans-first:5.98 03:49:18 INFO - PID 4124 | Values: 78.0 89.0 78.0 79.0 79.0 77.0 78.0 87.0 93.0 78.0 03:49:18 INFO - PID 4124 | 03:49:18 INFO - PID 4124 | [#11] stanford-crypto-ccm Cycles:10 Average:134.70 Median:132.00 stddev:10.69 (8.1%) stddev-sans-first:11.22 03:49:18 INFO - PID 4124 | Values: 139.0 131.0 128.0 126.0 133.0 128.0 128.0 143.0 130.0 161.0 03:49:18 INFO - PID 4124 | 03:49:18 INFO - PID 4124 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.70 Median:176.00 stddev:6.77 (3.8%) stddev-sans-first:7.13 03:49:18 INFO - PID 4124 | Values: 179.0 183.0 176.0 171.0 176.0 192.0 176.0 169.0 171.0 174.0 03:49:18 INFO - PID 4124 | 03:49:18 INFO - PID 4124 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:3.59 (5.3%) stddev-sans-first:2.37 03:49:18 INFO - PID 4124 | Values: 76.0 66.0 65.0 68.0 64.0 65.0 68.0 67.0 71.0 70.0 03:49:18 INFO - PID 4124 | -------- Summary: end -------- 03:49:18 INFO - PID 4124 | 03:49:18 INFO - PID 4124 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:49:19 INFO - TEST-INFO | 4124: exit 0 03:49:19 INFO - TEST-OK | kraken | took 61020ms 03:49:19 INFO - SUITE-END | took 1175s 03:49:19 INFO - Completed test suite (00:19:35) 03:49:19 INFO - javascript benchmark 03:49:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8598.074641728594, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3103.92240193995, 3142.1673256586996, 3159.4155081309955, 3198.216436972941, 3216.1477208539727, 6205.162303089081, 6236.781712640059, 6249.875002499947, 6287.842803929904, 6392.55252132351, 6276.1527193828815, 6335.904961425582, 6368.872622547547, 6382.489400847932, 6406.487481001509, 5700.287464066992, 5755.0, 5768.451997060293, 5853.32686741026, 5876.7355469004, 5679.829605111853, 5722.656640601556, 5763.250777398932, 5766.884662306772, 5855.121731740252, 5736.4550367715, 5798.536117110642, 5803.73883175256, 5810.912836307459, 5812.0, 5729.28383952006, 5761.683107429089, 5819.0689489681445, 5821.796237131723, 5829.09649004405, 5594.552435805166, 5644.379118296984, 5689.7439615217, 5737.799177028784, 5755.884882302373, 6204.937950620481, 6210.285817131043, 6235.438810507076, 6243.157173781527, 6270.498360131179, 6757.898631520531, 6788.355106264897, 6829.078074459983, 6829.795106146824, 6834.282400347991, 6789.219239787389, 6790.728370865159, 6810.523263371566, 6891.655417229119, 6899.206591241971, 6223.813285601439, 6260.248770147566, 6291.842703932347, 6355.110284560165, 6377.426031657127, 6947.444204463631, 6952.0, 6962.303769622998, 6969.407600353925, 6971.860562788817, 6513.348665133543, 6611.73553057882, 6639.203295604461, 6640.169978752656, 6644.900326495106, 6730.293319201512, 6748.0, 6750.291219421988, 6751.426128779109, 6752.459803215731, 6694.397504224643, 6704.597724136567, 6746.460283177334, 6801.829954251084, 6815.250322464525, 6789.966050169717, 6793.830154246183, 6869.450443964571, 6885.0, 6889.483288753364, 5357.973210134002, 5448.673079615236, 5507.834764957058, 5514.972425137848, 5521.282233309644, 4646.581807637329, 4651.325557794101, 4702.694324868872, 4716.386869706985, 4739.454962679267, 5915.349311575723, 5921.7631294747725, 5930.28836539618, 5932.169496270526, 5947.672877991666, 6730.663466826639, 6793.558418702769, 6845.14435695538, 6847.0, 6903.482238832108, 5724.427557244242, 5840.123981402823, 5885.764569417261, 5964.075568286922, 5969.582129250911, 5960.284765828128, 5960.552958528041, 5964.582479226413, 5972.283326000821, 5980.923433781874, 6534.117894084333, 6537.509686773511, 6645.102911107036, 6653.201615806038, 6655.401013908771, 6734.925370151184, 6849.931500684929, 6875.965620171867, 6886.208086070166, 6899.310068993061, 6502.089707441057, 6591.538592298493, 6627.271000190071, 6628.204615446178, 6637.734490620321, 6639.3692599203, 6649.700763465559, 6663.500237482305, 6737.663116844236, 6752.831179220559, 6698.866022679422, 6817.5568588041615, 6818.897716534355, 6850.691718872563, 6883.518153729191, 6557.639329836714, 6566.277709452052, 6574.76988305407, 6579.440747536321, 6586.571872828251, 6548.3124271952665, 6557.96721016411, 6569.9343006569325, 6600.042993765973, 6609.20689517261, 5640.802571910128, 6338.809835704937, 6414.10202571631, 6415.967920160369, 6434.292227855026, 6441.903371449525, 6452.290248072614, 6479.449246814073, 6551.6069035858, 6575.506836987341, 6343.5876668016435, 6347.650879201688, 6424.678766061772, 6426.742930282736, 6454.644994525346], "value": 6165.339697257175, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [773.3967505345829, 851.506126446661, 880.616931634739, 882.6072397782989, 1187.7861984842725, 29420.264493387676, 30267.394652106974, 40940.59059409409, 41368.0, 41531.0, 41763.0, 42048.57951420485, 42123.57876421235, 42287.365689514685, 42333.15333693325, 7239.457040721941, 7650.808729781745, 7798.142204357516, 7801.453898227126, 7806.80482987927, 7631.732889348874, 7743.10954240264, 7747.186545412735, 7748.0, 7756.689732410697, 7761.728339508119, 7788.14330423653, 7790.0, 7822.217778222161, 7827.491213071161, 7707.229277072276, 7795.5712435816295, 7813.101493328283, 7818.218178182193, 7822.491538050009, 7638.809029774245, 7663.425243106789, 7712.884306735404, 7714.228577142297, 7717.7298794542485, 38857.805710971545, 39014.414783778266, 39030.414543781866, 39051.0, 39146.21707565861, 3545.06055895188, 3575.856965721368, 3576.998440436682, 3581.301646178996, 3589.425691889285, 31366.843165784252, 31443.842780785948, 31519.84240078808, 31540.211494712585, 31712.414379280945, 5000.699958002531, 5054.898902021939, 5082.288479612857, 5103.744812759384, 5112.182050871843, 188590.0, 189600.0519997405, 191000.0, 191668.0, 192078.03960980245, 49010.75494622504, 49104.7544762281, 49446.50553494491, 49604.50395495999, 49831.501684983414, 50991.0, 50991.235131473055, 51179.0, 51189.232161517604, 51245.74377128165, 14126.646833829236, 14243.43026278958, 14248.643783905485, 14301.57095287143, 14346.21095839718, 10288.382697038052, 10412.531436085394, 11504.194706370641, 11518.424078796026, 11521.942390287995, 14275.928620356832, 14312.427502899976, 14408.207548584718, 14452.988290819541, 14506.637334066732, 5787.942120578825, 5849.415058494116, 5893.587448878623, 5895.263092113486, 5903.203067585821, 999.9350042247231, 1013.6553571785628, 1015.3755440404099, 1017.811704834608, 1029.325791606499, 22977.425564361023, 23740.762592373856, 23834.165804197117, 23913.0, 23957.640635390482, 1084.4306738962107, 1087.8694556653095, 1099.230538622967, 1101.1576144249655, 1120.1263014848432, 11904.702382440508, 12301.815472767916, 12386.442610082568, 12436.0, 12446.81329780054, 236075.0, 236896.0, 238638.0, 238662.0, 238755.0, 55147.72426137843, 55155.17267240994, 55448.44551554433, 55501.16748248779, 55556.16665750017, 1426.1514398932618, 1452.3319273134266, 1455.2360010994312, 1459.299536222619, 1473.2265560580781, 22461.775382245967, 22724.318270451913, 22845.657315139953, 22856.428589285402, 23066.654000190345, 37349.25301493901, 37663.0, 37789.43315850209, 37798.24403511969, 37814.62185378111, 210088.0, 210394.0, 213992.0, 214553.0, 215389.0, 35103.47344789779, 35353.0, 35394.8230258847, 36912.81543592372, 38229.61770382261, 45832.7708361456, 47441.76279118582, 47713.04573908572, 47787.76106119447, 47932.28101578549, 35062.0, 35568.82215588906, 35772.46341304934, 35776.28447431089, 36556.45165322469, 34739.826300868335, 34837.65162348445, 34840.30319393649, 35053.29893402169, 35121.0, 38029.0, 38078.47686092525, 38112.23775524418, 38213.42679859749, 38421.807890961485, 33560.66439335673, 33734.0, 33822.49266261057, 33894.32211355808, 34028.65971340255, 24739.0, 25641.871790640926, 25709.35726606775, 26166.0, 26490.602640960016], "value": 17394.788624974455, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.0042425754926, 570.3213176320179, 577.4946921443736, 587.4976894754984, 588.5703436491361, 21661.45846353842, 22444.3266701999, 22511.0, 22560.435989100282, 24402.511949760996, 25928.74071259287, 26524.20427387177, 26528.469430611378, 26596.867015664895, 26612.73387266127, 6387.265464471587, 6559.9672001640165, 6565.34346565342, 6571.112899758543, 6572.277049524549, 5912.0, 6426.357364263583, 6454.612723236597, 6462.063000864871, 6487.351264873522, 6397.296297407282, 6406.935930640704, 6407.8398040048905, 6407.9359206408035, 6414.871702565946, 6393.552451328409, 6401.743930242785, 6404.871902561946, 6412.422881940624, 6418.326075762071, 5950.791722289742, 5968.0, 5980.372060933626, 5994.340622531518, 5998.880022399528, 29162.270943226376, 30148.54777178344, 30329.241768955733, 30470.390592188254, 31004.22489437782, 1976.545394559245, 2004.2383894120287, 2009.4875806669352, 2014.0231987486059, 2018.3541266794632, 18101.4569562912, 19202.711959320623, 20112.899435502728, 20204.595908081905, 20281.188752449885, 2391.964120538193, 2434.6226334918115, 2456.8157388195777, 2461.778439940396, 2530.835495692774, 147761.0, 149383.0, 151639.24180379137, 152162.0, 160405.19797401055, 14905.925470372578, 15204.847951520343, 15537.611559711098, 15589.376424943102, 15656.37374505007, 23517.882410587838, 23836.64245036326, 23868.0, 23901.521969560512, 23924.7607523926, 9070.410423322463, 9212.585433655502, 9243.815123697623, 9319.813603727887, 9691.224702023821, 8376.790580235422, 8410.873836892451, 8416.452930559493, 8422.53676047811, 8431.451955622864, 8857.247133993555, 9235.769105772275, 9297.535123243946, 9502.619895204252, 9504.144626983605, 2639.788816894644, 2692.7576518113465, 2700.8649567521547, 2717.3885875677815, 2776.3753155539844, 945.262695097811, 964.0889359555154, 978.9853152202722, 979.397670432693, 979.8285300072458, 19431.0, 19488.902555487133, 19718.0, 20152.29466968649, 20205.898970505346, 1030.721705139608, 1038.8389799580925, 1041.109851077318, 1047.984280235797, 1052.9157667386592, 10937.890621093846, 11050.834237486444, 11132.666020019413, 11195.104391648649, 11195.552177912956, 495250.0, 508279.0, 512785.0, 518614.0, 518729.0, 118842.0, 121429.0, 122199.0, 128234.0, 130477.0, 1233.8951189148843, 1267.8351814264086, 1302.5766625846447, 1302.8501722302058, 1309.6987692830703, 21127.788722113197, 21212.681809772555, 21456.678149827454, 21525.677114842976, 21558.568828623655, 57745.422545774, 58276.125858111314, 58413.0, 59943.40056599378, 61108.69445652743, 70978.0, 71523.0, 71830.64084679753, 71886.28113719005, 72703.27296726964, 12649.810252846031, 14792.556223313319, 15376.154311512973, 15407.84592154109, 22099.889500552395, 24518.264452066465, 24836.627450587894, 25361.746382535937, 25424.237272881845, 25651.615225772002, 18774.624507510045, 19032.809671903105, 19524.804751952866, 19556.706649399985, 19727.11227994715, 17247.56881077983, 17422.73865892038, 17681.204345804726, 17775.46673599794, 17998.460046198634, 19413.32053378125, 19872.60254794925, 19940.0, 20036.799632003494, 20055.59888802245, 21265.787342126998, 21344.679829802255, 21417.393695473213, 21555.353339399844, 21599.35201943944, 18363.908180459013, 18601.0, 19047.23811047598, 19812.405627831187, 19914.0], "value": 12365.49952375544, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1376.3393571085878, 1429.821272340958, 1432.1120905038874, 1432.792245124457, 1441.5819412370413, 13594.252316122609, 14074.155550666954, 14135.717285654293, 14247.216403097826, 14260.144391336502, 13719.108257963251, 14098.083624564397, 14636.536346365358, 14642.853571464282, 14677.412903483875, 2638.0898589986423, 2711.4712631036955, 2715.3618899558587, 2716.4838680650714, 2728.6589176352954, 2588.0424243030106, 2647.7881769458495, 2656.2296933889147, 2692.3269182704325, 2693.178580532937, 2208.712867327245, 2291.46150654596, 2649.562822134355, 2749.4363655450584, 2749.8212616179985, 2719.7008329083783, 2735.466584016118, 2735.5623100303956, 2736.4390299988454, 2736.58951157326, 2589.7151313355516, 2623.265485664017, 2660.521106200883, 2674.0640775728534, 2674.638923745289, 13863.098898571561, 14089.577312680636, 14104.224267665275, 14146.787798183035, 14148.0, 7556.962215188943, 7793.220677932218, 7820.865974433732, 7863.764087077339, 7880.487768295043, 5017.272495488134, 5173.482651734834, 5315.282436871012, 5325.121354976424, 5328.413874473805, 1873.7470441490361, 1899.420676693608, 1927.816857398559, 1974.861759676823, 1985.0967809646577, 22961.42596435086, 23194.3041708749, 23212.53574928509, 23239.0, 23278.06887724506, 6577.901331480031, 6621.9337806621315, 6635.469162466991, 6695.598264104169, 6733.293004234485, 16117.516474505783, 16119.194040297938, 16180.271887765079, 16219.27013284405, 16241.91879040621, 7392.223816499298, 7500.0, 7508.549487030796, 7510.061242344707, 7511.812204694927, 6727.159105111861, 6878.449724022066, 7124.964375178195, 7139.357457828821, 7172.282771722786, 5043.445221025684, 5170.586353091744, 5173.120569503193, 5173.379194496684, 5174.301469301596, 1405.620482469748, 1407.479232683893, 1407.8310602727533, 1423.0465588056027, 1424.7364237615866, 868.9044205137429, 895.3866601378077, 903.7559858838077, 905.6965916417942, 907.587047893207, 7245.731996900521, 7283.781486555412, 7313.707451701873, 7362.226966168475, 7366.484346095722, 675.4461341699857, 964.0841200859072, 992.4888682328607, 993.6621548673486, 1004.1163775877181, 5069.898602027939, 5077.873053173626, 5131.461196574381, 5249.976254630386, 5306.708131052752, 18914.243430262635, 19167.712484312746, 19703.211871524978, 20097.0, 20102.69845952312, 19226.423207303804, 19285.61428771445, 19375.806241937684, 19430.0, 19456.221751129797, 10251.231157663206, 10399.584016639401, 10702.09032232269, 10710.357378557312, 10854.728631784268, 8471.110533393905, 8534.871976920227, 8535.3598480113, 8540.786480337792, 8558.52928088961, 15875.52373428799, 16698.0, 16702.0, 16768.916155419145, 17076.402325918534, 16573.751393728864, 16600.418985335455, 16645.0845203515, 16963.83036169672, 17010.659786803946, 11660.591879284184, 11940.402979851146, 11956.641300760992, 11957.940210298893, 11978.880211198126, 12444.440000199831, 12531.812022819848, 12769.553065642658, 12804.61586152417, 13312.201267923956, 10356.637517686844, 10458.215633827645, 10550.0, 10587.682369528926, 10630.468476575985, 10320.535575898952, 10467.476626168509, 10470.476476176009, 10603.310784798963, 10660.0, 8566.400351975302, 8674.306055515417, 8682.652693892427, 8706.0, 8712.99800522948, 6640.966795165993, 6668.533202675766, 6680.565763225375, 6719.731210751515, 6764.661766911733, 6913.1358580177475, 7081.8937715935335, 7112.786616401516, 7186.281371862772, 7254.093238345207], "value": 6356.803547109754, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.19491009216114, 502.2537025112686, 519.5661622545175, 523.0350004242176, 524.8609118583573, 6212.316645169028, 6246.437820596146, 6266.561340706153, 6276.1527193828815, 6278.121063051177, 5818.41815818419, 5985.760569577212, 6004.159417681528, 6071.848203794907, 6101.0, 4937.827176048839, 4965.577925876287, 4966.9751651241695, 4975.651704380694, 4993.350864387625, 4746.098241334153, 4952.851414457554, 4954.900901981958, 4958.0, 5007.84976450707, 4857.785553611597, 4870.878228044309, 4892.119418504668, 4900.705957642535, 4931.5068493150575, 4807.591354734816, 4845.3216549683075, 4860.076585448754, 4879.024195160982, 4909.705417674951, 4418.4093726258525, 4420.403245561873, 4423.469183697976, 4447.110577884436, 4482.8879278017985, 5944.970275148597, 5946.464818166386, 5955.434233747787, 5998.130271110708, 6019.518438524908, 5608.411116832755, 5615.241942337773, 5644.830655080313, 5648.604597678164, 5679.914801277942, 6383.744650213986, 6395.232572091332, 6457.83855403614, 6495.6752162391695, 6520.4457621102265, 4805.687630304019, 4853.126437241295, 4861.586765124968, 4901.005680370522, 4930.309756634074, 6787.592744435349, 6825.146856642919, 6840.521163518605, 6841.8026845302375, 6856.965715171442, 4939.6542242042715, 4980.626453016038, 4980.77586508608, 4983.127952608279, 5038.193888977819, 5010.749462526859, 5080.212567052113, 5107.719075450812, 5112.676760105886, 5124.795008199705, 5582.134769110794, 5664.971675141598, 5681.375048744635, 5700.6009579329875, 5700.800471983461, 6405.814924239031, 6412.3267056959285, 6448.0, 6458.804006637765, 6519.608823470607, 1635.337688236266, 1685.6965746165808, 1710.2902295547458, 1719.733441316573, 1745.4152858792447, 1215.3194211241732, 1215.6231568213882, 1234.6913271682079, 1242.726600147966, 1243.881831226032, 5639.0, 5644.520215781705, 5721.256236689203, 5750.424957504216, 5759.798407055733, 6528.804135875931, 6584.176977877765, 6605.4055135037115, 6644.534882558271, 6670.39966403026, 5667.328138199241, 5730.34101078373, 5734.369219385864, 5739.713014349266, 5748.540116790647, 3530.6822385985383, 3547.1841476460045, 3576.302620988882, 3576.766015724571, 3592.2995015972156, 6481.902771458432, 6515.566575353415, 6547.181602299713, 6560.573562718408, 6588.24235212947, 6911.619860907598, 6923.9653801730665, 6938.27148149437, 6944.340287672663, 6961.13656920414, 6458.060583044339, 6488.902666460007, 6532.314107018885, 6569.704363303663, 6572.375624315682, 6622.271550129578, 6643.534952553468, 6648.700808463534, 6712.194536655633, 6742.460603151638, 6575.868482630416, 6602.372774586406, 6651.900221496585, 6660.700268487833, 6666.933330666825, 6339.714712838026, 6361.8727625448155, 6447.6131432114225, 6467.514936379885, 6542.34576542361, 4956.231784073474, 5009.21988296499, 5009.499050094962, 5013.323201367769, 5023.196288593807, 6801.149856267966, 6814.2163651180745, 6814.93185068143, 6823.577629941497, 6838.179418469816, 6363.0, 6440.871182576416, 6482.157319548429, 6489.805305840832, 6519.8044058678315, 6128.754849805958, 6326.4622507087415, 6357.682115894279, 6457.321981191907, 6464.935350646433, 6272.560920735687, 6349.68251587428, 6377.681115944277, 6406.5515413920575, 6435.485161187187, 6536.3136870627895, 6548.443382312366, 6563.212414510289, 6580.177477815273, 6586.70359833799, 6292.716827742671, 6293.992961126198, 6322.652254126067, 6326.462250708557, 6390.7763228286785], "value": 5019.137161850476, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [913.5432283858071, 918.4994178172897, 935.5556110847344, 938.9201917836988, 939.3002213351052, 17389.217485213198, 18613.7207941881, 19535.804641953575, 19604.607907841833, 19696.11367488463, 15565.221738913066, 18520.722189167172, 18529.629407411845, 18597.721034184466, 18616.25534978599, 1026.2251999740204, 1049.574922156528, 1050.406520316019, 1052.0741747262437, 1052.8104941110596, 1025.4308858583483, 1058.5871510111062, 1061.517009760561, 1063.2025980514613, 1066.221658189522, 1108.2962318927498, 1128.4978184707809, 1129.1080046763047, 1129.824877144044, 1130.1015692524463, 1118.7706520163347, 1130.8869113088667, 1131.0894729742554, 1131.4003578103618, 1132.1508868348737, 815.2825513548099, 816.9264766171013, 819.9385046121565, 822.6627082895984, 822.8354329134137, 19492.512687182792, 19682.606347873105, 19751.80248197514, 19869.30457433983, 20695.68956465639, 20205.696914546294, 20460.897695511576, 21807.80057096859, 22145.00347484367, 22360.32919012432, 18146.818531814777, 19171.424857254304, 19187.52031199217, 19271.90364048171, 19309.61380772391, 3605.2248766515063, 3612.3858943979585, 3615.837287322077, 3618.240169564395, 3630.782153070798, 122733.0, 123183.0, 124922.0, 125154.37422812919, 127688.0, 17258.0, 17949.0, 18064.36774712879, 18240.0, 18257.269709211483, 32421.0, 32439.675603243664, 32812.0, 33051.66948330534, 33397.16507087342, 8704.78238044054, 8904.0, 8983.910160898438, 8989.55052247385, 9048.954755226181, 4114.485689288839, 4180.665546756252, 4183.6653067754505, 4195.748255104703, 4223.260929337353, 5001.624878134155, 5231.29377534028, 5244.239585260116, 5425.620206585501, 5848.3274423441, 1152.6599653102355, 1174.7533018066301, 1176.2942234659306, 1178.6169494914186, 1179.33367647279, 662.2351184381951, 673.2358772792916, 675.1965161457849, 677.2459330334359, 697.5396238482679, 11957.461914213882, 12254.448549815279, 12531.43608537618, 12980.896623786895, 13365.26491043002, 652.6051738698114, 681.1213534540387, 720.330093013492, 725.9237780033126, 733.9522931009467, 5494.313210848644, 5679.545636349082, 5737.598368114275, 5905.586608937333, 5940.34656187819, 108996.0, 110808.44595777131, 111223.44388278006, 112979.0, 113591.43204284091, 95548.0, 98477.0, 98645.50677246568, 99669.00330996598, 102909.0, 83178.16821831826, 86654.56672716723, 89308.0, 89536.55231723799, 89613.0, 12878.420471078636, 13308.600741977756, 13381.53164639233, 13438.0, 13513.0, 38506.422403664525, 39619.0, 41388.379174311805, 42171.57828421799, 43831.34252986144, 82015.58992205001, 82162.58918705369, 83899.5805020971, 84888.57555712182, 85824.14175858161, 19325.226990920204, 19438.31965881244, 19561.608767824848, 19731.90134049378, 20550.38348849537, 22077.116915323208, 22153.446163846034, 22310.442238944157, 22342.994565244928, 22594.0, 18511.90744046271, 18679.346222882134, 18864.434066978014, 19584.412467625993, 19938.30215942493, 18592.0, 20478.385648430572, 20572.588548228654, 20607.690884636442, 20737.170513179302, 16958.660826783642, 17187.398441055004, 17958.0, 18313.267469301078, 18383.54041148982, 14315.713685726436, 14793.0, 14943.925280373529, 14949.626259343604, 15053.6989260212, 14529.85470145285, 14562.854371456573, 14951.252437378305, 15059.774103388678, 15848.92075539661], "value": 9548.250188017071, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1522.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 107.0, 101.0, 107.0, 106.0, 110.0, 108.0, 98.0, 108.0, 109.0], "value": 105.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 122.0, 147.0, 174.0, 125.0, 145.0, 146.0, 117.0, 165.0, 119.0], "value": 140.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 162.0, 164.0, 164.0, 164.0, 162.0, 163.0, 171.0, 172.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 172.0, 75.0, 74.0, 74.0, 88.0, 97.0, 76.0], "value": 88.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 138.0, 80.0, 80.0, 79.0, 131.0, 78.0, 78.0, 125.0], "value": 94.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 113.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 151.0, 150.0, 150.0, 151.0, 150.0, 152.0, 152.0, 149.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 56.0, 55.0, 55.0, 56.0, 56.0, 55.0, 54.0, 55.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 55.0, 53.0, 54.0, 53.0, 54.0, 53.0, 54.0], "value": 53.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 89.0, 78.0, 79.0, 79.0, 77.0, 78.0, 87.0, 93.0, 78.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 131.0, 128.0, 126.0, 133.0, 128.0, 128.0, 143.0, 130.0, 161.0], "value": 134.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 183.0, 176.0, 171.0, 176.0, 192.0, 176.0, 169.0, 171.0, 174.0], "value": 176.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 66.0, 65.0, 68.0, 64.0, 65.0, 68.0, 67.0, 71.0, 70.0], "value": 68.0, "unit": "score"}]}]} 03:49:19 INFO - Return code: 0 03:49:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:49:19 INFO - # TBPL SUCCESS # 03:49:19 INFO - Running post-action listener: _package_coverage_data 03:49:19 INFO - Running post-action listener: _resource_record_post_action 03:49:19 INFO - [mozharness: 2017-08-10 10:49:19.806120Z] Finished run-tests step (success) 03:49:19 INFO - Running post-run listener: _resource_record_post_run 03:49:19 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 7098368; Write bytes: 440893440; Read time: 4092; Write time: 357124 03:49:19 INFO - TinderboxPrint: CPU usage
13.1% 03:49:19 INFO - TinderboxPrint: I/O read bytes / time
7,098,368 / 4,092 03:49:19 INFO - TinderboxPrint: I/O write bytes / time
440,893,440 / 357,124 03:49:19 INFO - TinderboxPrint: CPU idle
8,267.9 (86.8%) 03:49:19 INFO - TinderboxPrint: CPU user
1,202.6 (12.6%) 03:49:19 INFO - TinderboxPrint: Swap in / out
0 / 0 03:49:19 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 8192; Write bytes: 162127872; Read time: 232; Write time: 146740 03:49:19 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:49:19 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4902912; Write bytes: 196976640; Read time: 3496; Write time: 98068 03:49:20 INFO - Running post-run listener: _upload_blobber_files 03:49:20 INFO - Blob upload gear active. 03:49:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:49:20 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:49:20 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:49:20 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:49:20 INFO - (blobuploader) - INFO - Open directory for files ... 03:49:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:49:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:49:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:21 INFO - (blobuploader) - INFO - Done attempting. 03:49:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:49:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:49:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:25 INFO - (blobuploader) - INFO - Done attempting. 03:49:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:49:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:26 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:49:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:26 INFO - (blobuploader) - INFO - Done attempting. 03:49:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:49:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:49:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:26 INFO - (blobuploader) - INFO - Done attempting. 03:49:26 INFO - (blobuploader) - INFO - Iteration through files over. 03:49:26 INFO - Return code: 0 03:49:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:49:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:49:26 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f33ce122c563a31bda397601947a3213c00c01e6220afa87cd172a1c64cccbcc80d1fb7cd269ccb1b4a90499b88cafac291b7e5e9fd326110887aa321d1c6c95", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fe2bc1cfc45384bcde24c2a5c56cecc48f5d68f80b98f3b534740ab2ed4c7947629a18dbc3fc1af22b72dc70cd1068667811588ca4a235c5ff45874d3b28104b", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b002ec1225c6ef855b818a0ff6526533a804131ed8fb02a51f56948471829e2ebaea7dff79c104d38e5e7a6f84d0d1c64b5fd78c82def8a29077e05955974d18", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e24d9acdf2cb4f8af3d03e36f35cf876612f8e732b56a1108e674bb99493737427384edecd005692de4555bb384dcfb5be99e6068bc3852187c30ebcf9bed84f"} 03:49:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:49:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:49:26 INFO - Contents: 03:49:26 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f33ce122c563a31bda397601947a3213c00c01e6220afa87cd172a1c64cccbcc80d1fb7cd269ccb1b4a90499b88cafac291b7e5e9fd326110887aa321d1c6c95", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fe2bc1cfc45384bcde24c2a5c56cecc48f5d68f80b98f3b534740ab2ed4c7947629a18dbc3fc1af22b72dc70cd1068667811588ca4a235c5ff45874d3b28104b", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b002ec1225c6ef855b818a0ff6526533a804131ed8fb02a51f56948471829e2ebaea7dff79c104d38e5e7a6f84d0d1c64b5fd78c82def8a29077e05955974d18", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e24d9acdf2cb4f8af3d03e36f35cf876612f8e732b56a1108e674bb99493737427384edecd005692de4555bb384dcfb5be99e6068bc3852187c30ebcf9bed84f"} 03:49:26 INFO - Running post-run listener: copy_logs_to_upload_dir 03:49:26 INFO - Copying logs to upload dir... 03:49:26 INFO - mkdir: /builds/slave/test/build/upload/logs 03:49:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.916344 ========= master_lag: 0.15 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-10 03:49:26.815863) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-10 03:49:26.825717) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1502360128.715639-1924894432 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f33ce122c563a31bda397601947a3213c00c01e6220afa87cd172a1c64cccbcc80d1fb7cd269ccb1b4a90499b88cafac291b7e5e9fd326110887aa321d1c6c95", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fe2bc1cfc45384bcde24c2a5c56cecc48f5d68f80b98f3b534740ab2ed4c7947629a18dbc3fc1af22b72dc70cd1068667811588ca4a235c5ff45874d3b28104b", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b002ec1225c6ef855b818a0ff6526533a804131ed8fb02a51f56948471829e2ebaea7dff79c104d38e5e7a6f84d0d1c64b5fd78c82def8a29077e05955974d18", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e24d9acdf2cb4f8af3d03e36f35cf876612f8e732b56a1108e674bb99493737427384edecd005692de4555bb384dcfb5be99e6068bc3852187c30ebcf9bed84f"} build_url:https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011231 build_url: 'https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f33ce122c563a31bda397601947a3213c00c01e6220afa87cd172a1c64cccbcc80d1fb7cd269ccb1b4a90499b88cafac291b7e5e9fd326110887aa321d1c6c95", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fe2bc1cfc45384bcde24c2a5c56cecc48f5d68f80b98f3b534740ab2ed4c7947629a18dbc3fc1af22b72dc70cd1068667811588ca4a235c5ff45874d3b28104b", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b002ec1225c6ef855b818a0ff6526533a804131ed8fb02a51f56948471829e2ebaea7dff79c104d38e5e7a6f84d0d1c64b5fd78c82def8a29077e05955974d18", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e24d9acdf2cb4f8af3d03e36f35cf876612f8e732b56a1108e674bb99493737427384edecd005692de4555bb384dcfb5be99e6068bc3852187c30ebcf9bed84f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-10 03:49:26.849844) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-10 03:49:26.850140) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1502360128.715639-1924894432 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004534 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-10 03:49:26.933217) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-10 03:49:26.935548) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-10 03:49:26.935836) ========= ========= Total master_lag: 0.36 =========