builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-037 starttime: 1500940261.31 results: success (0) revision: 899590a34d56e099d4e064a9e4d41a54993790e9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-24 16:51:01.308155) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-24 16:51:01.308541) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-24 16:51:01.308811) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-24 16:51:01.389465) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 16:51:01.389718) ========= 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-1500938396.991606-1626508640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-24 16:51:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 82.8M=0s 2017-07-24 16:51:01 (82.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.112069 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 16:51:01.582220) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 16:51:01.582504) ========= 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-1500938396.991606-1626508640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017404 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 16:51:01.633109) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 16:51:01.633745) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 899590a34d56e099d4e064a9e4d41a54993790e9 --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 899590a34d56e099d4e064a9e4d41a54993790e9 --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-1500938396.991606-1626508640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-24 16:51:02,054 truncating revision to first 12 chars 2017-07-24 16:51:02,054 Setting DEBUG logging. 2017-07-24 16:51:02,054 attempt 1/10 2017-07-24 16:51:02,054 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/899590a34d56?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-24 16:51:02,355 unpacking tar archive at: mozilla-central-899590a34d56/testing/mozharness/ program finished with exit code 0 elapsedTime=0.653915 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 16:51:02.307980) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-24 16:51:02.311264) ========= script_repo_revision: 899590a34d56e099d4e064a9e4d41a54993790e9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-24 16:51:02.311608) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-24 16:51:02.311865) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-24 16:51:02.328923) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-07-24 16:51:02.329207) ========= /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-1500938396.991606-1626508640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:51:02 INFO - MultiFileLogger online at 20170724 16:51:02 in /builds/slave/test 16:51:02 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 16:51:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:51:02 INFO - {'append_to_log': False, 16:51:02 INFO - 'base_work_dir': '/builds/slave/test', 16:51:02 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:51:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:51:02 INFO - 'branch': 'Firefox-Non-PGO', 16:51:02 INFO - 'buildbot_json_path': 'buildprops.json', 16:51:02 INFO - 'code_coverage': False, 16:51:02 INFO - 'config_files': ('talos/linux_config.py',), 16:51:02 INFO - 'default_actions': ('clobber', 16:51:02 INFO - 'read-buildbot-config', 16:51:02 INFO - 'download-and-extract', 16:51:02 INFO - 'populate-webroot', 16:51:02 INFO - 'create-virtualenv', 16:51:02 INFO - 'install', 16:51:02 INFO - 'setup-mitmproxy', 16:51:02 INFO - 'run-tests'), 16:51:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:51:02 INFO - 'disable_ccov_upload': False, 16:51:02 INFO - 'download_minidump_stackwalk': True, 16:51:02 INFO - 'download_symbols': 'ondemand', 16:51:02 INFO - 'enable_stylo': False, 16:51:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:51:02 INFO - 'tooltool.py': '/tools/tooltool.py', 16:51:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:51:02 INFO - '/tools/misc-python/virtualenv.py')}, 16:51:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:51:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:51:02 INFO - 'gecko_profile': False, 16:51:02 INFO - 'gecko_profile_interval': 0, 16:51:02 INFO - 'installer_path': 'installer.exe', 16:51:02 INFO - 'log_level': 'info', 16:51:02 INFO - 'log_name': 'talos', 16:51:02 INFO - 'log_to_console': True, 16:51:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:51:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:51:02 INFO - 'opt_config_files': (), 16:51:02 INFO - 'pip_index': False, 16:51:02 INFO - 'suite': 'dromaeojs-e10s', 16:51:02 INFO - 'system_bits': '32', 16:51:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:51:02 INFO - 'title': 'talos-linux64-ix-037', 16:51:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:51:02 INFO - 'use_talos_json': True, 16:51:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:51:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:51:02 INFO - 'work_dir': 'build'} 16:51:02 INFO - [mozharness: 2017-07-24 23:51:02.850382Z] Running clobber step. 16:51:02 INFO - Running pre-action listener: _resource_record_pre_action 16:51:02 INFO - Running main action method: clobber 16:51:02 INFO - rmtree: /builds/slave/test/build 16:51:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:51:03 INFO - Running post-action listener: _resource_record_post_action 16:51:03 INFO - [mozharness: 2017-07-24 23:51:03.896897Z] Finished clobber step (success) 16:51:03 INFO - [mozharness: 2017-07-24 23:51:03.897000Z] Running read-buildbot-config step. 16:51:03 INFO - Running pre-action listener: _resource_record_pre_action 16:51:03 INFO - Running main action method: read_buildbot_config 16:51:03 INFO - Using buildbot properties: 16:51:03 INFO - { 16:51:03 INFO - "project": "", 16:51:03 INFO - "product": "firefox", 16:51:03 INFO - "who": "kwierso@gmail.com", 16:51:03 INFO - "installer_path": "public/build/target.tar.bz2", 16:51:03 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 16:51:03 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 16:51:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 16:51:03 INFO - "stage_platform": "linux64", 16:51:03 INFO - "basedir": "/builds/slave/test", 16:51:03 INFO - "buildnumber": 739, 16:51:03 INFO - "platform": "ubuntu64_hw", 16:51:03 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:51:03 INFO - "slavebuilddir": "test", 16:51:03 INFO - "taskId": "bzdBR3QEQjeCY_E5-6TcFg", 16:51:03 INFO - "branch": "mozilla-central", 16:51:03 INFO - "script_repo_revision": "production", 16:51:03 INFO - "revision": "899590a34d56e099d4e064a9e4d41a54993790e9", 16:51:03 INFO - "slavename": "talos-linux64-ix-037", 16:51:03 INFO - "repo_path": "mozilla-central" 16:51:03 INFO - } 16:51:03 INFO - Finding installer, test and symbols from parent task. 16:51:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bzdBR3QEQjeCY_E5-6TcFg'}, attempt #1 16:51:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bzdBR3QEQjeCY_E5-6TcFg'}, attempt #1 16:51:04 INFO - Task dependencies: KME2DeJkTQawjPY1Qqlefg 16:51:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KME2DeJkTQawjPY1Qqlefg'}, attempt #1 16:51:05 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/KME2DeJkTQawjPY1Qqlefg/artifacts/public/build/target.tar.bz2 16:51:05 INFO - Set test_url: https://queue.taskcluster.net/v1/task/KME2DeJkTQawjPY1Qqlefg/artifacts/public/build/test_packages.json 16:51:05 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/KME2DeJkTQawjPY1Qqlefg/artifacts/public/build/target.crashreporter-symbols.zip 16:51:05 INFO - Running post-action listener: _resource_record_post_action 16:51:05 INFO - [mozharness: 2017-07-24 23:51:05.255162Z] Finished read-buildbot-config step (success) 16:51:05 INFO - [mozharness: 2017-07-24 23:51:05.255384Z] Running download-and-extract step. 16:51:05 INFO - Running pre-action listener: _resource_record_pre_action 16:51:05 INFO - Running main action method: download_and_extract 16:51:05 INFO - mkdir: /builds/slave/test/build/tests 16:51:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:51:05 INFO - trying https://queue.taskcluster.net/v1/task/KME2DeJkTQawjPY1Qqlefg/artifacts/public/build/target.test_packages.json 16:51:05 INFO - Downloading https://queue.taskcluster.net/v1/task/KME2DeJkTQawjPY1Qqlefg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:51:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KME2DeJkTQawjPY1Qqlefg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:51:05 INFO - Downloaded 989 bytes. 16:51:05 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:51:05 INFO - Using the following test package requirements: 16:51:05 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:51:05 INFO - u'common': [u'target.common.tests.zip'], 16:51:05 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:51:05 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:51:05 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:51:05 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:51:05 INFO - u'mozbase': [u'target.common.tests.zip'], 16:51:05 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:51:05 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:51:05 INFO - u'web-platform': [u'target.common.tests.zip', 16:51:05 INFO - u'target.web-platform.tests.tar.gz'], 16:51:05 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:51:05 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:51:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KME2DeJkTQawjPY1Qqlefg/artifacts/public/build/target.common.tests.zip 16:51:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KME2DeJkTQawjPY1Qqlefg/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:51:05 INFO - Fetch https://queue.taskcluster.net/v1/task/KME2DeJkTQawjPY1Qqlefg/artifacts/public/build/target.common.tests.zip into memory 16:51:10 INFO - Content-Length response header: 72761312 16:51:10 INFO - Bytes received: 72761312 16:51:21 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:51:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KME2DeJkTQawjPY1Qqlefg/artifacts/public/build/target.common.tests.zip 16:51:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KME2DeJkTQawjPY1Qqlefg/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:51:21 INFO - Fetch https://queue.taskcluster.net/v1/task/KME2DeJkTQawjPY1Qqlefg/artifacts/public/build/target.common.tests.zip into memory 16:51:24 INFO - Content-Length response header: 72761312 16:51:24 INFO - Bytes received: 72761312 16:51:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KME2DeJkTQawjPY1Qqlefg/artifacts/public/build/target.talos.tests.zip 16:51:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KME2DeJkTQawjPY1Qqlefg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:51:37 INFO - Fetch https://queue.taskcluster.net/v1/task/KME2DeJkTQawjPY1Qqlefg/artifacts/public/build/target.talos.tests.zip into memory 16:51:38 INFO - Content-Length response header: 14498976 16:51:38 INFO - Bytes received: 14498976 16:51:38 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')]} 16:51:38 INFO - trying https://queue.taskcluster.net/v1/task/KME2DeJkTQawjPY1Qqlefg/artifacts/public/build/target.tar.bz2 16:51:38 INFO - Downloading https://queue.taskcluster.net/v1/task/KME2DeJkTQawjPY1Qqlefg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:51:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KME2DeJkTQawjPY1Qqlefg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:51:42 INFO - Downloaded 61970372 bytes. 16:51:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KME2DeJkTQawjPY1Qqlefg/artifacts/public/build/target.tar.bz2 16:51:42 INFO - mkdir: /builds/slave/test/properties 16:51:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:51:42 INFO - Writing to file /builds/slave/test/properties/build_url 16:51:42 INFO - Contents: 16:51:42 INFO - build_url:https://queue.taskcluster.net/v1/task/KME2DeJkTQawjPY1Qqlefg/artifacts/public/build/target.tar.bz2 16:51:42 INFO - Running post-action listener: _resource_record_post_action 16:51:42 INFO - Running post-action listener: set_extra_try_arguments 16:51:42 INFO - [mozharness: 2017-07-24 23:51:42.312666Z] Finished download-and-extract step (success) 16:51:42 INFO - [mozharness: 2017-07-24 23:51:42.312894Z] Running populate-webroot step. 16:51:42 INFO - Running pre-action listener: _resource_record_pre_action 16:51:42 INFO - Running main action method: populate_webroot 16:51:42 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:51:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:51:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:51:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:51:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:51:42 INFO - 'tests': ['damp', 'tps']}, 16:51:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:51:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:51:42 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:51:42 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:51:42 INFO - 'other-e10s': {'tests': ['a11yr', 16:51:42 INFO - 'ts_paint', 16:51:42 INFO - 'tpaint', 16:51:42 INFO - 'sessionrestore', 16:51:42 INFO - 'sessionrestore_many_windows', 16:51:42 INFO - 'sessionrestore_no_auto_restore', 16:51:42 INFO - 'tabpaint']}, 16:51:42 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 16:51:42 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 16:51:42 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:51:42 INFO - 'talos_options': ['--mitmproxy', 16:51:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:51:42 INFO - '--firstNonBlankPaint'], 16:51:42 INFO - 'tests': ['quantum_pageload_google', 16:51:42 INFO - 'quantum_pageload_youtube', 16:51:42 INFO - 'quantum_pageload_amazon', 16:51:42 INFO - 'quantum_pageload_facebook']}, 16:51:42 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:51:42 INFO - 'talos_options': ['--stylo', 16:51:42 INFO - '--mitmproxy', 16:51:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:51:42 INFO - '--firstNonBlankPaint'], 16:51:42 INFO - 'tests': ['quantum_pageload_google', 16:51:42 INFO - 'quantum_pageload_youtube', 16:51:42 INFO - 'quantum_pageload_amazon', 16:51:42 INFO - 'quantum_pageload_facebook']}, 16:51:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:51:42 INFO - 'tsvgr_opacity', 16:51:42 INFO - 'tart', 16:51:42 INFO - 'tscrollx', 16:51:42 INFO - 'cart', 16:51:42 INFO - 'tsvg_static']}, 16:51:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:51:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:51:42 INFO - 'talos_options': ['--xperf_path', 16:51:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:51:42 INFO - 'tests': ['tp5n']}}} 16:51:42 INFO - Running post-action listener: _resource_record_post_action 16:51:42 INFO - [mozharness: 2017-07-24 23:51:42.328153Z] Finished populate-webroot step (success) 16:51:42 INFO - [mozharness: 2017-07-24 23:51:42.328243Z] Running create-virtualenv step. 16:51:42 INFO - Running pre-action listener: _resource_record_pre_action 16:51:42 INFO - Running main action method: create_virtualenv 16:51:42 INFO - Creating virtualenv /builds/slave/test/build/venv 16:51:42 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 16:51:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:51:42 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:51:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:51:42 INFO - Using real prefix '/usr' 16:51:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:51:42 INFO - Installing distribute.............................................................................................................................................................................................done. 16:51:44 INFO - Installing pip.................done. 16:51:44 INFO - Return code: 0 16:51:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:51:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:51:45 INFO - Reading from file tmpfile_stdout 16:51:45 INFO - Output received: 16:51:45 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) 16:51:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:51:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:51:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:45 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 0xf5f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cfd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cceb0>, '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 0x12cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ce240>, '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-1500938396.991606-1626508640', '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 16:51:45 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 16:51:45 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 16:51:45 INFO - Using env: {'DISPLAY': ':0', 16:51:45 INFO - 'HOME': '/home/cltbld', 16:51:45 INFO - 'LANG': 'en_US.UTF-8', 16:51:45 INFO - 'LANGUAGE': 'en_US:en', 16:51:45 INFO - 'LOGNAME': 'cltbld', 16:51:45 INFO - 'MAIL': '/var/mail/cltbld', 16:51:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:45 INFO - 'MOZ_NO_REMOTE': '1', 16:51:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:45 INFO - 'NO_EM_RESTART': '1', 16:51:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:45 INFO - 'PWD': '/builds/slave/test', 16:51:45 INFO - 'SHELL': '/bin/bash', 16:51:45 INFO - 'SHLVL': '1', 16:51:45 INFO - 'TERM': 'linux', 16:51:45 INFO - 'TMOUT': '86400', 16:51:45 INFO - 'USER': 'cltbld', 16:51:45 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1500938396.991606-1626508640', 16:51:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:45 INFO - '_': '/tools/buildbot/bin/python'} 16:51:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:45 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 16:51:45 INFO - Cleaning up... 16:51:45 INFO - Return code: 0 16:51:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:51:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:51:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:45 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 0xf5f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cfd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cceb0>, '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 0x12cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ce240>, '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-1500938396.991606-1626508640', '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 16:51:45 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 16:51:45 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 16:51:45 INFO - Using env: {'DISPLAY': ':0', 16:51:45 INFO - 'HOME': '/home/cltbld', 16:51:45 INFO - 'LANG': 'en_US.UTF-8', 16:51:45 INFO - 'LANGUAGE': 'en_US:en', 16:51:45 INFO - 'LOGNAME': 'cltbld', 16:51:45 INFO - 'MAIL': '/var/mail/cltbld', 16:51:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:45 INFO - 'MOZ_NO_REMOTE': '1', 16:51:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:45 INFO - 'NO_EM_RESTART': '1', 16:51:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:45 INFO - 'PWD': '/builds/slave/test', 16:51:45 INFO - 'SHELL': '/bin/bash', 16:51:45 INFO - 'SHLVL': '1', 16:51:45 INFO - 'TERM': 'linux', 16:51:45 INFO - 'TMOUT': '86400', 16:51:45 INFO - 'USER': 'cltbld', 16:51:45 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1500938396.991606-1626508640', 16:51:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:45 INFO - '_': '/tools/buildbot/bin/python'} 16:51:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:45 INFO - Downloading/unpacking psutil>=3.1.1 16:51:45 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 16:51:45 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 16:51:45 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 16:51:45 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 16:51:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:51:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:51:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:51:46 INFO - Installing collected packages: psutil 16:51:46 INFO - Running setup.py install for psutil 16:51:46 INFO - building 'psutil._psutil_linux' extension 16:51:46 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 16:51:46 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 16:51:46 INFO - building 'psutil._psutil_posix' extension 16:51:46 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 16:51:47 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 16:51:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:51:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:51:47 INFO - Successfully installed psutil 16:51:47 INFO - Cleaning up... 16:51:47 INFO - Return code: 0 16:51:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:51:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:51:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:47 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 0xf5f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cfd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cceb0>, '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 0x12cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ce240>, '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-1500938396.991606-1626508640', '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 16:51:47 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 16:51:47 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 16:51:47 INFO - Using env: {'DISPLAY': ':0', 16:51:47 INFO - 'HOME': '/home/cltbld', 16:51:47 INFO - 'LANG': 'en_US.UTF-8', 16:51:47 INFO - 'LANGUAGE': 'en_US:en', 16:51:47 INFO - 'LOGNAME': 'cltbld', 16:51:47 INFO - 'MAIL': '/var/mail/cltbld', 16:51:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:47 INFO - 'MOZ_NO_REMOTE': '1', 16:51:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:47 INFO - 'NO_EM_RESTART': '1', 16:51:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:47 INFO - 'PWD': '/builds/slave/test', 16:51:47 INFO - 'SHELL': '/bin/bash', 16:51:47 INFO - 'SHLVL': '1', 16:51:47 INFO - 'TERM': 'linux', 16:51:47 INFO - 'TMOUT': '86400', 16:51:47 INFO - 'USER': 'cltbld', 16:51:47 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1500938396.991606-1626508640', 16:51:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:47 INFO - '_': '/tools/buildbot/bin/python'} 16:51:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:51:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:51:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:51:48 INFO - Installing collected packages: mozsystemmonitor 16:51:48 INFO - Running setup.py install for mozsystemmonitor 16:51:48 INFO - Successfully installed mozsystemmonitor 16:51:48 INFO - Cleaning up... 16:51:48 INFO - Return code: 0 16:51:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:51:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:51:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:48 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 0xf5f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cfd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cceb0>, '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 0x12cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ce240>, '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-1500938396.991606-1626508640', '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 16:51:48 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 16:51:48 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 16:51:48 INFO - Using env: {'DISPLAY': ':0', 16:51:48 INFO - 'HOME': '/home/cltbld', 16:51:48 INFO - 'LANG': 'en_US.UTF-8', 16:51:48 INFO - 'LANGUAGE': 'en_US:en', 16:51:48 INFO - 'LOGNAME': 'cltbld', 16:51:48 INFO - 'MAIL': '/var/mail/cltbld', 16:51:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:48 INFO - 'MOZ_NO_REMOTE': '1', 16:51:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:48 INFO - 'NO_EM_RESTART': '1', 16:51:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:48 INFO - 'PWD': '/builds/slave/test', 16:51:48 INFO - 'SHELL': '/bin/bash', 16:51:48 INFO - 'SHLVL': '1', 16:51:48 INFO - 'TERM': 'linux', 16:51:48 INFO - 'TMOUT': '86400', 16:51:48 INFO - 'USER': 'cltbld', 16:51:48 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1500938396.991606-1626508640', 16:51:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:48 INFO - '_': '/tools/buildbot/bin/python'} 16:51:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:48 INFO - Downloading/unpacking jsonschema==2.5.1 16:51:48 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 16:51:48 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 16:51:48 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 16:51:48 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 16:51:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:51:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:50 INFO - Downloading functools32-3.2.3-2.tar.gz 16:51:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:51:50 INFO - warning: no files found matching '*.txt' 16:51:50 INFO - no previously-included directories found matching 'build' 16:51:50 INFO - no previously-included directories found matching 'dist' 16:51:50 INFO - no previously-included directories found matching '.git*' 16:51:50 INFO - Installing collected packages: jsonschema, functools32 16:51:50 INFO - Running setup.py install for functools32 16:51:50 INFO - warning: no files found matching '*.txt' 16:51:50 INFO - no previously-included directories found matching 'build' 16:51:50 INFO - no previously-included directories found matching 'dist' 16:51:50 INFO - no previously-included directories found matching '.git*' 16:51:50 INFO - Successfully installed jsonschema functools32 16:51:50 INFO - Cleaning up... 16:51:50 INFO - Return code: 0 16:51:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:51:50 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')]} 16:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:50 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')]} 16:51:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:50 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 0xf5f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cfd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cceb0>, '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 0x12cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ce240>, '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-1500938396.991606-1626508640', '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 16:51:50 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 16:51:50 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 16:51:50 INFO - Using env: {'DISPLAY': ':0', 16:51:50 INFO - 'HOME': '/home/cltbld', 16:51:50 INFO - 'LANG': 'en_US.UTF-8', 16:51:50 INFO - 'LANGUAGE': 'en_US:en', 16:51:50 INFO - 'LOGNAME': 'cltbld', 16:51:50 INFO - 'MAIL': '/var/mail/cltbld', 16:51:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:50 INFO - 'MOZ_NO_REMOTE': '1', 16:51:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:50 INFO - 'NO_EM_RESTART': '1', 16:51:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:50 INFO - 'PWD': '/builds/slave/test', 16:51:50 INFO - 'SHELL': '/bin/bash', 16:51:50 INFO - 'SHLVL': '1', 16:51:50 INFO - 'TERM': 'linux', 16:51:50 INFO - 'TMOUT': '86400', 16:51:50 INFO - 'USER': 'cltbld', 16:51:50 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1500938396.991606-1626508640', 16:51:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:50 INFO - '_': '/tools/buildbot/bin/python'} 16:51:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:51:50 INFO - Cleaning up... 16:51:50 INFO - Return code: 0 16:51:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:51:50 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')]} 16:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:50 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')]} 16:51:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:50 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 0xf5f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cfd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cceb0>, '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 0x12cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ce240>, '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-1500938396.991606-1626508640', '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 16:51:50 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 16:51:50 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 16:51:50 INFO - Using env: {'DISPLAY': ':0', 16:51:50 INFO - 'HOME': '/home/cltbld', 16:51:50 INFO - 'LANG': 'en_US.UTF-8', 16:51:50 INFO - 'LANGUAGE': 'en_US:en', 16:51:50 INFO - 'LOGNAME': 'cltbld', 16:51:50 INFO - 'MAIL': '/var/mail/cltbld', 16:51:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:50 INFO - 'MOZ_NO_REMOTE': '1', 16:51:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:50 INFO - 'NO_EM_RESTART': '1', 16:51:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:50 INFO - 'PWD': '/builds/slave/test', 16:51:50 INFO - 'SHELL': '/bin/bash', 16:51:50 INFO - 'SHLVL': '1', 16:51:50 INFO - 'TERM': 'linux', 16:51:50 INFO - 'TMOUT': '86400', 16:51:50 INFO - 'USER': 'cltbld', 16:51:50 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1500938396.991606-1626508640', 16:51:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:50 INFO - '_': '/tools/buildbot/bin/python'} 16:51:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:50 INFO - Downloading/unpacking blobuploader==1.2.4 16:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:51 INFO - Downloading blobuploader-1.2.4.tar.gz 16:51:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:51:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:51:52 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 16:51:52 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 16:51:52 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 16:51:52 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 16:51:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:51:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:51:52 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 16:51:52 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 16:51:52 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 16:51:52 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 16:51:52 INFO - Downloading docopt-0.6.1.tar.gz 16:51:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:51:52 INFO - Installing collected packages: blobuploader, requests, docopt 16:51:52 INFO - Running setup.py install for blobuploader 16:51:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:51:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:51:52 INFO - Running setup.py install for requests 16:51:53 INFO - Running setup.py install for docopt 16:51:53 INFO - Successfully installed blobuploader requests docopt 16:51:53 INFO - Cleaning up... 16:51:53 INFO - Return code: 0 16:51:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:51:53 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')]} 16:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:53 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')]} 16:51:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:53 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 0xf5f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cfd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cceb0>, '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 0x12cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ce240>, '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-1500938396.991606-1626508640', '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 16:51:53 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 16:51:53 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 16:51:53 INFO - Using env: {'DISPLAY': ':0', 16:51:53 INFO - 'HOME': '/home/cltbld', 16:51:53 INFO - 'LANG': 'en_US.UTF-8', 16:51:53 INFO - 'LANGUAGE': 'en_US:en', 16:51:53 INFO - 'LOGNAME': 'cltbld', 16:51:53 INFO - 'MAIL': '/var/mail/cltbld', 16:51:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:53 INFO - 'MOZ_NO_REMOTE': '1', 16:51:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:53 INFO - 'NO_EM_RESTART': '1', 16:51:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:53 INFO - 'PWD': '/builds/slave/test', 16:51:53 INFO - 'SHELL': '/bin/bash', 16:51:53 INFO - 'SHLVL': '1', 16:51:53 INFO - 'TERM': 'linux', 16:51:53 INFO - 'TMOUT': '86400', 16:51:53 INFO - 'USER': 'cltbld', 16:51:53 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1500938396.991606-1626508640', 16:51:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:53 INFO - '_': '/tools/buildbot/bin/python'} 16:51:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:51:53 INFO - Running setup.py (path:/tmp/pip-Pr6Jh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:51:53 INFO - Running setup.py (path:/tmp/pip-XPzciU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:51:53 INFO - Running setup.py (path:/tmp/pip-34MXYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:51:53 INFO - Running setup.py (path:/tmp/pip-it4fbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:51:53 INFO - Running setup.py (path:/tmp/pip-TjlExy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:51:53 INFO - Running setup.py (path:/tmp/pip-ZNnNRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:51:53 INFO - Running setup.py (path:/tmp/pip-V5Zxjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:51:53 INFO - Running setup.py (path:/tmp/pip-T1x2Wl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:51:53 INFO - Running setup.py (path:/tmp/pip-9hAFnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:51:54 INFO - Running setup.py (path:/tmp/pip-P_XHAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:51:54 INFO - Running setup.py (path:/tmp/pip-529bo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:51:54 INFO - Running setup.py (path:/tmp/pip-ZHDolu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:51:54 INFO - Running setup.py (path:/tmp/pip-eaCpwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:51:54 INFO - Running setup.py (path:/tmp/pip-93JBIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:51:54 INFO - Running setup.py (path:/tmp/pip-5M7gdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:51:54 INFO - Running setup.py (path:/tmp/pip-IfMNeg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:51:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:51:54 INFO - Running setup.py (path:/tmp/pip-bxUfj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:51:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:51:54 INFO - Running setup.py install for manifestparser 16:51:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:51:54 INFO - Running setup.py install for mozcrash 16:51:54 INFO - Running setup.py install for mozdebug 16:51:54 INFO - Running setup.py install for mozdevice 16:51:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:51:55 INFO - Running setup.py install for mozfile 16:51:55 INFO - Running setup.py install for mozhttpd 16:51:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:51:55 INFO - Running setup.py install for mozinfo 16:51:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:51:55 INFO - Running setup.py install for mozInstall 16:51:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:51:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:51:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:51:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:51:55 INFO - Running setup.py install for mozleak 16:51:55 INFO - Running setup.py install for mozlog 16:51:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:51:55 INFO - Running setup.py install for moznetwork 16:51:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:51:55 INFO - Running setup.py install for mozprocess 16:51:55 INFO - Running setup.py install for mozprofile 16:51:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:51:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:51:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:51:55 INFO - Running setup.py install for mozrunner 16:51:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:51:56 INFO - Running setup.py install for mozscreenshot 16:51:56 INFO - Running setup.py install for moztest 16:51:56 INFO - Running setup.py install for mozversion 16:51:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:51:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:51:56 INFO - Cleaning up... 16:51:56 INFO - Return code: 0 16:51:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:51:56 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')]} 16:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:56 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')]} 16:51:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:56 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 0xf5f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cfd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cceb0>, '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 0x12cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ce240>, '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-1500938396.991606-1626508640', '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 16:51:56 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 16:51:56 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 16:51:56 INFO - Using env: {'DISPLAY': ':0', 16:51:56 INFO - 'HOME': '/home/cltbld', 16:51:56 INFO - 'LANG': 'en_US.UTF-8', 16:51:56 INFO - 'LANGUAGE': 'en_US:en', 16:51:56 INFO - 'LOGNAME': 'cltbld', 16:51:56 INFO - 'MAIL': '/var/mail/cltbld', 16:51:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:56 INFO - 'MOZ_NO_REMOTE': '1', 16:51:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:56 INFO - 'NO_EM_RESTART': '1', 16:51:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:56 INFO - 'PWD': '/builds/slave/test', 16:51:56 INFO - 'SHELL': '/bin/bash', 16:51:56 INFO - 'SHLVL': '1', 16:51:56 INFO - 'TERM': 'linux', 16:51:56 INFO - 'TMOUT': '86400', 16:51:56 INFO - 'USER': 'cltbld', 16:51:56 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1500938396.991606-1626508640', 16:51:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:56 INFO - '_': '/tools/buildbot/bin/python'} 16:51:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:51:56 INFO - Running setup.py (path:/tmp/pip-O6WXav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:51:56 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)) 16:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:51:56 INFO - Running setup.py (path:/tmp/pip-p0tI4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:51:56 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)) 16:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:51:56 INFO - Running setup.py (path:/tmp/pip-bfI8bH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:51:56 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)) 16:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:51:56 INFO - Running setup.py (path:/tmp/pip-sTZbYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:51:56 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)) 16:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:51:56 INFO - Running setup.py (path:/tmp/pip-L2pgw8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:51:56 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)) 16:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:51:56 INFO - Running setup.py (path:/tmp/pip-xhGVCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:51:57 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)) 16:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:51:57 INFO - Running setup.py (path:/tmp/pip-843i4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:51:57 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)) 16:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:51:57 INFO - Running setup.py (path:/tmp/pip-16z8NL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:51:57 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)) 16:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:51:57 INFO - Running setup.py (path:/tmp/pip-CbNnpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:51:57 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)) 16:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:51:57 INFO - Running setup.py (path:/tmp/pip-jTsrVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:51:57 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)) 16:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:51:57 INFO - Running setup.py (path:/tmp/pip-_mfMJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:51:57 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)) 16:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:51:57 INFO - Running setup.py (path:/tmp/pip-wHbHgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:51:57 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)) 16:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:51:57 INFO - Running setup.py (path:/tmp/pip-gSIzhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:51:57 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)) 16:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:51:57 INFO - Running setup.py (path:/tmp/pip-RQqFQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:51:57 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)) 16:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:51:57 INFO - Running setup.py (path:/tmp/pip-ecDcla-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:51:57 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)) 16:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:51:57 INFO - Running setup.py (path:/tmp/pip-0KRe_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:51:57 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)) 16:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:51:57 INFO - Running setup.py (path:/tmp/pip-zJoAmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:51:57 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)) 16:51:57 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)) 16:51:57 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)) 16:51:57 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)) 16:51:57 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)) 16:51:57 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)) 16:51:57 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)) 16:51:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:51:57 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 16:51:57 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 16:51:57 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 16:51:57 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 16:51:58 INFO - Downloading blessings-1.6.tar.gz 16:51:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:51:59 INFO - Installing collected packages: blessings 16:51:59 INFO - Running setup.py install for blessings 16:51:59 INFO - Successfully installed blessings 16:51:59 INFO - Cleaning up... 16:51:59 INFO - Return code: 0 16:51:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:51:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:51:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:51:59 INFO - Reading from file tmpfile_stdout 16:51:59 INFO - Current package versions: 16:51:59 INFO - argparse == 1.2.1 16:51:59 INFO - blessings == 1.6 16:51:59 INFO - blobuploader == 1.2.4 16:51:59 INFO - docopt == 0.6.1 16:51:59 INFO - functools32 == 3.2.3-2 16:51:59 INFO - jsonschema == 2.5.1 16:51:59 INFO - manifestparser == 1.1 16:51:59 INFO - mozInstall == 1.13 16:51:59 INFO - mozcrash == 1.0 16:51:59 INFO - mozdebug == 0.1 16:51:59 INFO - mozdevice == 0.51 16:51:59 INFO - mozfile == 1.2 16:51:59 INFO - mozhttpd == 0.7 16:51:59 INFO - mozinfo == 0.10 16:51:59 INFO - mozleak == 0.1 16:51:59 INFO - mozlog == 3.5 16:51:59 INFO - moznetwork == 0.27 16:51:59 INFO - mozprocess == 0.25 16:51:59 INFO - mozprofile == 0.28 16:51:59 INFO - mozrunner == 6.13 16:51:59 INFO - mozscreenshot == 0.1 16:51:59 INFO - mozsystemmonitor == 0.3 16:51:59 INFO - moztest == 0.8 16:51:59 INFO - mozversion == 1.4 16:51:59 INFO - psutil == 3.1.1 16:51:59 INFO - requests == 1.2.3 16:51:59 INFO - wsgiref == 0.1.2 16:51:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:51:59 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')]} 16:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:59 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')]} 16:51:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:59 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 0xf5f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cfd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cceb0>, '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 0x12cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ce240>, '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-1500938396.991606-1626508640', '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 16:51:59 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 16:51:59 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 16:51:59 INFO - Using env: {'DISPLAY': ':0', 16:51:59 INFO - 'HOME': '/home/cltbld', 16:51:59 INFO - 'LANG': 'en_US.UTF-8', 16:51:59 INFO - 'LANGUAGE': 'en_US:en', 16:51:59 INFO - 'LOGNAME': 'cltbld', 16:51:59 INFO - 'MAIL': '/var/mail/cltbld', 16:51:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:59 INFO - 'MOZ_NO_REMOTE': '1', 16:51:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:59 INFO - 'NO_EM_RESTART': '1', 16:51:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:59 INFO - 'PWD': '/builds/slave/test', 16:51:59 INFO - 'SHELL': '/bin/bash', 16:51:59 INFO - 'SHLVL': '1', 16:51:59 INFO - 'TERM': 'linux', 16:51:59 INFO - 'TMOUT': '86400', 16:51:59 INFO - 'USER': 'cltbld', 16:51:59 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1500938396.991606-1626508640', 16:51:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:59 INFO - '_': '/tools/buildbot/bin/python'} 16:51:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:59 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)) 16:51:59 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)) 16:51:59 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)) 16:51:59 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)) 16:51:59 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)) 16:51:59 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)) 16:51:59 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)) 16:51:59 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)) 16:51:59 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)) 16:51:59 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:51:59 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 16:51:59 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 16:51:59 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 16:51:59 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 16:52:00 INFO - Downloading marionette_driver-1.4.0.tar.gz 16:52:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 16:52:00 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 16:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:52:01 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)) 16:52:01 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)) 16:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:52:01 INFO - Installing collected packages: marionette-driver, simplejson 16:52:01 INFO - Running setup.py install for marionette-driver 16:52:01 INFO - Running setup.py install for simplejson 16:52:01 INFO - building 'simplejson._speedups' extension 16:52:01 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 16:52:02 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 16:52:02 INFO - Successfully installed marionette-driver simplejson 16:52:02 INFO - Cleaning up... 16:52:02 INFO - Return code: 0 16:52:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:52: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')]} 16:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52: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')]} 16:52:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cfd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cceb0>, '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 0x12cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ce240>, '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-1500938396.991606-1626508640', '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 16:52:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:52:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:52:02 INFO - Using env: {'DISPLAY': ':0', 16:52:02 INFO - 'HOME': '/home/cltbld', 16:52:02 INFO - 'LANG': 'en_US.UTF-8', 16:52:02 INFO - 'LANGUAGE': 'en_US:en', 16:52:02 INFO - 'LOGNAME': 'cltbld', 16:52:02 INFO - 'MAIL': '/var/mail/cltbld', 16:52:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:02 INFO - 'MOZ_NO_REMOTE': '1', 16:52:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:02 INFO - 'NO_EM_RESTART': '1', 16:52:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:02 INFO - 'PWD': '/builds/slave/test', 16:52:02 INFO - 'SHELL': '/bin/bash', 16:52:02 INFO - 'SHLVL': '1', 16:52:02 INFO - 'TERM': 'linux', 16:52:02 INFO - 'TMOUT': '86400', 16:52:02 INFO - 'USER': 'cltbld', 16:52:02 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1500938396.991606-1626508640', 16:52:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:02 INFO - '_': '/tools/buildbot/bin/python'} 16:52:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:52:02 INFO - Cleaning up... 16:52:02 INFO - Return code: 0 16:52:02 INFO - Running post-action listener: _resource_record_post_action 16:52:02 INFO - Running post-action listener: _start_resource_monitoring 16:52:02 INFO - Starting resource monitoring. 16:52:02 INFO - [mozharness: 2017-07-24 23:52:02.441806Z] Finished create-virtualenv step (success) 16:52:02 INFO - [mozharness: 2017-07-24 23:52:02.442342Z] Running install step. 16:52:02 INFO - Running pre-action listener: _resource_record_pre_action 16:52:02 INFO - Running main action method: install 16:52:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:52:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:52:02 INFO - Reading from file tmpfile_stdout 16:52:02 INFO - Detecting whether we're running mozinstall >=1.0... 16:52:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:52:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:52:02 INFO - Reading from file tmpfile_stdout 16:52:02 INFO - Output received: 16:52:02 INFO - Usage: mozinstall [options] installer 16:52:02 INFO - Options: 16:52:02 INFO - -h, --help show this help message and exit 16:52:02 INFO - -d DEST, --destination=DEST 16:52:02 INFO - Directory to install application into. [default: 16:52:02 INFO - "/builds/slave/test"] 16:52:02 INFO - --app=APP Application being installed. [default: firefox] 16:52:02 INFO - mkdir: /builds/slave/test/build/application 16:52:02 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'] 16:52:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:52:20 INFO - Reading from file tmpfile_stdout 16:52:20 INFO - Output received: 16:52:20 INFO - /builds/slave/test/build/application/firefox/firefox 16:52:20 INFO - Running post-action listener: _resource_record_post_action 16:52:20 INFO - [mozharness: 2017-07-24 23:52:20.774609Z] Finished install step (success) 16:52:20 INFO - [mozharness: 2017-07-24 23:52:20.774866Z] Running setup-mitmproxy step. 16:52:20 INFO - Running pre-action listener: _resource_record_pre_action 16:52:20 INFO - Running main action method: setup_mitmproxy 16:52:20 INFO - Skipping: mitmproxy is not required 16:52:20 INFO - Running post-action listener: _resource_record_post_action 16:52:20 INFO - [mozharness: 2017-07-24 23:52:20.775999Z] Finished setup-mitmproxy step (success) 16:52:20 INFO - [mozharness: 2017-07-24 23:52:20.776220Z] Running run-tests step. 16:52:20 INFO - Running pre-action listener: _resource_record_pre_action 16:52:20 INFO - Running pre-action listener: _set_gcov_prefix 16:52:20 INFO - Running main action method: run_tests 16:52:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:52:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:52:20 INFO - Python 2.7.3 16:52:20 INFO - Return code: 0 16:52:20 INFO - grabbing minidump binary from tooltool 16:52:20 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')]} 16:52:20 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 0x12cceb0>, '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 0x12cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ce240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:52:20 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 16:52:20 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 16:52:20 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 16:52:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:52:20 INFO - Return code: 0 16:52:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:52:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:52:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:52:20 INFO - ENV: RUST_BACKTRACE is now 1 16:52:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:52:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:52:20 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/KME2DeJkTQawjPY1Qqlefg/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 16:52:20 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/KME2DeJkTQawjPY1Qqlefg/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 16:52:20 INFO - Using env: {'DISPLAY': ':0', 16:52:20 INFO - 'HOME': '/home/cltbld', 16:52:20 INFO - 'LANG': 'en_US.UTF-8', 16:52:20 INFO - 'LANGUAGE': 'en_US:en', 16:52:20 INFO - 'LOGNAME': 'cltbld', 16:52:20 INFO - 'MAIL': '/var/mail/cltbld', 16:52:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:52:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:52:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:20 INFO - 'MOZ_NO_REMOTE': '1', 16:52:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:52:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:20 INFO - 'NO_EM_RESTART': '1', 16:52:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:20 INFO - 'PWD': '/builds/slave/test', 16:52:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:52:20 INFO - 'RUST_BACKTRACE': '1', 16:52:20 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:52:20 INFO - 'SHELL': '/bin/bash', 16:52:20 INFO - 'SHLVL': '1', 16:52:20 INFO - 'TERM': 'linux', 16:52:20 INFO - 'TMOUT': '86400', 16:52:20 INFO - 'USER': 'cltbld', 16:52:20 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1500938396.991606-1626508640', 16:52:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:20 INFO - '_': '/tools/buildbot/bin/python'} 16:52:20 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/KME2DeJkTQawjPY1Qqlefg/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 16:52:21 INFO - mozversion application_buildid: 20170724231022 16:52:21 INFO - mozversion application_changeset: 899590a34d56e099d4e064a9e4d41a54993790e9 16:52:21 INFO - mozversion application_display_name: Nightly 16:52:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:52:21 INFO - mozversion application_name: Firefox 16:52:21 INFO - mozversion application_remotingname: firefox 16:52:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:52:21 INFO - mozversion application_vendor: Mozilla 16:52:21 INFO - mozversion application_version: 56.0a1 16:52:21 INFO - mozversion platform_buildid: 20170724231022 16:52:21 INFO - mozversion platform_changeset: 899590a34d56e099d4e064a9e4d41a54993790e9 16:52:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:52:21 INFO - mozversion platform_version: 56.0a1 16:52:21 INFO - using testdate: 1500940341 16:52:21 INFO - actual date: 1500940341 16:52:21 INFO - starting webserver on 'localhost:41488' 16:52:21 INFO - SUITE-START | Running 2 tests 16:52:21 INFO - TEST-START | dromaeo_css 16:52:21 INFO - Initialising browser for dromaeo_css test... 16:52:21 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41488/getInfo.html -profile /tmp/tmpRrXKd7/profile 16:52:21 INFO - TEST-INFO | started process 23880 (/builds/slave/test/build/application/firefox/firefox http://localhost:41488/getInfo.html) 16:52:26 INFO - TEST-INFO | 23880: exit 0 16:52:27 INFO - Browser initialized. 16:52:27 INFO - Running cycle 1/1 for dromaeo_css test... 16:52:27 INFO - TEST-INFO | started process 24087 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRrXKd7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:52:38 INFO - PID 24087 | RSS: Main: 176988160 16:52:38 INFO - PID 24087 | 16:55:37 INFO - PID 24087 | Cycle 1(1): loaded http://localhost:41488/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41488/tests/dromaeo/cssquery-ext.html) 16:55:39 INFO - PID 24087 | RSS: Main: 178909184 16:55:39 INFO - PID 24087 | 16:58:40 INFO - PID 24087 | Cycle 1(1): loaded http://localhost:41488/tests/dromaeo/cssquery-ext.html (next: http://localhost:41488/tests/dromaeo/cssquery-jquery.html) 16:58:41 INFO - PID 24087 | RSS: Main: 173465600 16:58:41 INFO - PID 24087 | 17:01:43 INFO - PID 24087 | Cycle 1(1): loaded http://localhost:41488/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41488/tests/dromaeo/cssquery-mootools.html) 17:01:44 INFO - PID 24087 | RSS: Main: 178143232 17:01:44 INFO - PID 24087 | 17:04:45 INFO - PID 24087 | Cycle 1(1): loaded http://localhost:41488/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41488/tests/dromaeo/cssquery-prototype.html) 17:04:46 INFO - PID 24087 | RSS: Main: 176381952 17:04:46 INFO - PID 24087 | 17:07:50 INFO - PID 24087 | Cycle 1(1): loaded http://localhost:41488/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41488/tests/dromaeo/cssquery-yui.html) 17:07:50 INFO - PID 24087 | RSS: Main: 178155520 17:07:50 INFO - PID 24087 | 17:10:52 INFO - PID 24087 | Cycle 1(1): loaded http://localhost:41488/tests/dromaeo/cssquery-yui.html (next: http://localhost:41488/tests/dromaeo/cssquery-dojo.html) 17:10:52 INFO - PID 24087 | RSS: Main: 180510720 17:10:52 INFO - PID 24087 | 17:10:52 INFO - PID 24087 | __start_tp_report 17:10:52 INFO - PID 24087 | _x_x_mozilla_page_load 17:10:52 INFO - PID 24087 | _x_x_mozilla_page_load_details 17:10:52 INFO - PID 24087 | |i|pagename|runs| 17:10:52 INFO - PID 24087 | |0;dojo.html;3137.435261652902;3141.5758872552196;3149.5118256670216;3187.7927934684258;3217.967820321796;5911.379305172959;5974.402559744023;6025.3070896846875;6065.211522502074;6102.328743838174;5990.430909063632;6032;6065.454109130177;6075.422834830695;6084.787032453865;5523.751431185597;5527.2538207341895;5627.6904770237625;5644.068728659766;5669.0646043402785;5376.1398176291805;5593.860153496154;5632.183333416652;5676.716164191795;5697.344805347397;5511.090670039439;5543.334799824007;5547.417521160261;5604.971975140098;5639.718014099279;5551.444855514456;5576.191452239443;5625.212470254168;5639.718014099279;5650.604457687922;5446.428125046853;5506.421825708283;5527.143292789624;5563.749631266603;5584.329880414376;5995.880082398371;6009.248843894513;6016.939830601682;6080.908786368208;6107;6500.609963402211;6526.216853977506;6569.93430065698;6601.966990165067;6610.405063544256;6475.222973243241;6557.770478033293;6558.081868538408;6616.106825578533;6653.135092438;6038.6678732670125;6125.540584456184;6136.048912418582;6136.60112092717;6141.416565426322;6631.966840165768;6647.833804154838;6743.055972163901;6743.561668491532;6755.256921738604;6362.872742545123;6417.294097649255;6430.292667806538;6450.096986421905;6486.870262594722;6520.0871877937125;6594.86810263792;6624.403803657598;6626.834329141713;6627;6468.256150542654;6488.740450382026;6530.640814755234;6543.1821022372205;6601.70292336846;6367.108604795332;6462.450691691165;6504.674766261668;6550.705218265094;6570.901436478457;5316.096263635114;5368.087425137736;5379.1662292344745;5388.08402571556;5390.51485366311;4534.682572219979;4540.727556346564;4585.862424127282;4603.194440972817;4632.745199014019;5758.424157584208;5781.739821707949;5808.215890854765;5817.243758311477;5821.592488525763;6529.640869752209;6566.934330656728;6593.274739778621;6669.599824010575;6688;5636.746346414421;5681.659100453903;5715.31416230055;5806.738696758656;5809.564282678816;5766.682832444172;5862.648241105548;5865.589408741433;5868.882622347529;5891.381404952418;6339.175907132043;6364.522660800366;6432.292447830641;6454.6449945252525;6472.320406357265;6449.484041276781;6578.506612004215;6587.176602924635;6658.201015877932;6672.366125218096;6339.3343698912795;6356.396142366468;6359.87280254383;6360.77737279193;6365.96817015912;6421.325760795049;6474.902876456763;6481.546291759721;6525.445337146396;6538.1827271591055;6518.250401203923;6525.0538671893255;6544.803655890331;6643.335666433318;6687.63218022994;6275.278342990432;6325.683715814099;6376.649284289409;6382.6170429774365;6438.066480360415;6203.8138855834395;6225.937740622536;6242.500599952084;6338.651374174465;6369.90445143314;6222.81331560054;6369.299377068426;6382.872342553216;6388.776392826228;6399.616023038632;6392;6406.071119687526;6460.160179176865;6528.608283503005;6534.509911756542;6076.483498902643;6181.227346581677;6197.628142311476;6289.245290565162;6293.874122517433 17:10:52 INFO - PID 24087 | |1;ext.html;827.9834403311934;857.5112186053948;886.9778255543615;896.7892545251863;1157.4849192109514;31309.68690313096;41848.37227441591;42574.36138457926;42654.786726066406;42666.57333426665;43303;43412.131757364914;43452.56547434525;43517;43629.345559816626;7209.963950180242;7567.6972921083225;7694.5383277003275;7722.343600793939;7814.296713295802;7586.355159811423;7643.350315223212;7677.385809135256;7679.2704693054075;7712.768616941501;7629.160792312841;7749.070111586618;7750.689972401097;7757.495762775401;7758.8448231035345;7677.884831727529;7680.11678656956;7696.307332340089;7721.112072111723;7732.922670773305;7585.12771031333;7717.073951125901;7719.536827790294;7721.03487064117;7721.53670779755;39261.21477570433;39627.20745585101;39641;39725.20549588992;39754.403683944765;3534.0634731796094;3577.0878426001464;3582.140286331288;3587.443946188345;3587.6232995535356;32287.677123228936;32323;32352;32538.18654533632;32606;4874.8537543873745;4939.234418665113;4955.90088198234;4989.176785830334;5016.122178618763;184637.07681461642;186328;186642;186820;187082.06458967755;48999.265011024865;49040;49273.26090108579;49379;49523.752381237864;52017.47982520202;52028.47971520236;52111.478885210665;52127.73936130295;52237.21644175341;16431.342746290255;16748.748768768477;16753.497395078168;16754.74867876983;16779.832201677826;11202.551897924155;11242.213045086766;11275.097992160607;11308.264962777394;13829.51596694111;15974.201289935456;16028.118453484936;16082.919585401998;16085.06979162508;16178.11020393866;6274.047350169455;6326.335734747785;6337.366263373718;6340.778072767524;6485.54601177913;1015.3045164062493;1024.4058446101244;1028.711960651019;1034.591336422109;1049.1239814754613;23404.350706603876;24565.877170614032;24582.139625113035;29550.261243468656;30445.543316850264;1062.4262898035129;1097.3635291530893;1102.0687519046394;1110.9000189982778;1121.6466812953893;12251.632451026484;15979.342826177139;16133.515994520183;16179.838201617833;16587.336506539603;230629;232190;232418;232512;233739;58263.70868145717;58579.12131318034;58941.70529147327;58957.705211474524;59005.40994590085;1445.4868521674864;1463.948761793332;1477.8152730908637;1483.5771805035297;1513.9772903406458;27558.862205689646;28079.71920280771;28164.15507534777;28290.85854570714;28329.575056374582;38311;38674.806625967816;38700.41949370706;38756;38803.80598096991;202151;202467;202511;203965;204185;30918.536221956238;31710.68289317077;34829;34844.65155348414;35014.299714005065;43279.78360108305;43344;43868.78065609652;44115.55884441114;44301.11397772091;30051.549226762054;31544.842275788473;31989.200269993435;32066.519002215453;32241;30296;31777.523337149498;32312.192195195308;32320.030399088064;34537.136571585914;38178.618213817506;38468;38717;38853;39153.804230979804;32960.505592415655;33851.15372115717;34058.8297058523;34171.4874276891;34292;23909.40226494282;24557.894894730136;24902;25240.873795630905;25401.491970160863 17:10:52 INFO - PID 24087 | |2;jquery.html;584.6462889951579;588.7733222709261;594.6432140715569;600.3906035374096;611.3428064830307;22769.658455123164;22947.885260573716;23698.52602947942;23734.64398034031;23778.40553986149;26027.089051883187;26433.207003789918;26528.204153875366;26566.734332656666;26846.328841778966;6602.636854972987;6801.7959461216;6804.557703749265;6816.147981502312;6819.5908245505425;6114.388561143895;6310.747570097191;6380.904286435707;6644.833879153036;6708.329167083277;6384.58500197488;6386.10594516768;6391;6393.232812062559;6397.5521713480075;6314.431701146873;6341.873162536746;6381.744730210832;6396.5202609804455;6397.776077837277;5849.064149736065;5885.646861188299;5893.616914900518;5903;5917.349091599921;29404;30185;30406.54390184149;30468.84765576158;30821.22946926345;1938.185961896007;1990.5023744063983;1993.7308463357551;1995.311617491963;1998.3005947918257;19164.137613807412;19428.22287108514;19437.4168774937;19492.610147797106;19593.706094408597;2271.261839902022;2289.381866895945;2307.14635584833;2314.247869442438;2314.93055208344;134020;135483;136659.31670341684;136784;139263;13844.584662460142;14865.993090932801;14968.625784355478;15128.243587820565;15818;24105.879470602536;24139.758602413753;24153.15463958753;24160.87919560391;24221.51556968851;9776.1690256329;9799.902000980042;9802.705918822447;9983.101520863012;10024.348417352849;8509.361797865186;8937.195652391316;9106.27149828012;9106.453612783254;9164.541772911327;8309.95845020771;9115.635374585076;9298.814023719488;9540;9684.661036863818;2651.9469610608066;2665.6934452537816;2725.427660191382;2754.254214268593;2839.4321135772516;947.5688561704408;948.7248697877676;951.0876178516231;987.7234374375042;998.3011891675711;18939.90530047341;19546.804531954782;19733.506662333268;19814.997557887815;20486;993.8445435741492;1016.2378216337746;1019.1439191079529;1044.2429238801808;1046.5813674530098;10651.360918344924;10671.413072280944;10719.249652524404;11228.75771485972;11235.943820280847;485782;490575;494045;495341;498420;113833;117746.41126794311;119341;119871;119990;1227.846519185102;1239.3988915376035;1286.4854058376536;1294.9604373112386;1300.0314765499763;16874.662506750043;17535.912320438318;17703.645927081645;18107.18517666682;18320.633587327913;52915.470845291056;54271.45728542664;54504.90990180254;54746.45253547573;54915;70482;70660.64669676618;71200.64399677969;71615.64192179005;71927;12664;13282.804547590764;14185.432582696576;14301;14725.263736813331;22453.8773061343;22907.427314317276;23423.297301080995;24069.398265043514;24404;19241.90379048096;19619.411417657495;19628.509287267363;19637.410877673694;19857.808531488157;15986.760198597263;17535;17764.911175444042;18092.819071809114;18131;19245.326413575458;20193.697094543888;20208.59582808365;20245.79754202498;20306.477014223696;14945.103293802407;15138.394464221308;15238.085714857145;15251.923740381228;15268.465603703817;18438.35465758692;19689.113989870202;19723.112459939624;19752;19818.60362792765 17:10:52 INFO - PID 24087 | |3;mootools.html;1343.838739351278;1370.2395170680275;1395.9651008724782;1426.507854790097;1428.257306200775;13435.925125989921;13444.731105377887;14101;14106.64733381666;14115.43538258471;14062.859371406283;14432.711345773077;14441.711165776678;14449;14451.132932024086;2698.716634753357;2755.3662657588766;2759.9172024839286;2761.254461295449;2761.7514423701864;2636.8681565921725;2661.3878807874203;2698.932526686829;2699.311675522739;2699.392636656756;2549.79601631869;2620.6200100985347;2637.762601365877;2675.933101672454;2699.568069108943;2570.820042597019;2579.8968041278326;2592.8185027048116;2596.545604519202;2597.116980226732;2530.911418100376;2549.668543089405;2571.1386685460207;2571.241483762276;2578.1234380310784;13524.59426217215;13781;13797.51708690191;13798.65503362414;13816.378262978089;7392.260773922619;7649;7684.039495063117;7688.961555192244;7691.115521714963;4692.601128904047;4933.654644174909;4940.802367905279;4985.9252111218;5099.107656160194;1817.7000794868832;1827.0864567716142;1848.5563464768493;1863.8508919286423;1899.116910636547;21148.47128821792;21655.45861353479;21676.34970950874;21766;21767.891160544095;6620.172478440195;6674.199096108498;6679.198496180489;6857.382835544825;6906.171259448798;17537.386191483238;17540.298388064333;17589;17618;17649;7417.258274172647;7660.80847978805;7663.616819159131;7664.080310362792;7684.269994350528;5823.679697616587;5973.253343332083;6176.3514830943;6226.688665566794;6248.500119990481;5243.659162154448;5355.357357117093;5439.265699130567;5459.2902922619805;5486.862828429321;1669.607642204081;1676.9496915092566;1700;1718.518814731877;1725.1115675427166;868.0928429790883;871.7646235516376;878.5124256037833;905.1491597897955;911.6262332443666;6764.188297404343;7059.152901651834;7116.715331386687;7174.820629484305;7176.067111275605;698.769406095987;698.9934494328152;702.3257672634328;712.9500934934608;723.0961298377028;4407.338899165151;4965.751712414437;5051.974740126349;5097.898042039138;5130.102232109441;17695.557611059827;17796.911015445097;18167.091645417677;18275;18367.81632183688;17862.46412607624;18038.819611803978;18775.34286299973;18951.336703215322;19144.712829307573;10574.83676795552;10624.575016999388;10711;10726.034656880762;10779.245452818228;7438.940869830759;7498.625068746432;7512.774616761506;7654.043244594426;7664.195259497673;15861.841381586037;15933;16000.759988600414;16154.1115238663;16155.515334539983;16500;16506.58733531671;16626.58433539171;16867.91566042162;16872.156392180586;11131.775504694315;11574.537018519502;11578.942105289756;11584;11586.47860846247;12443.502259909865;12862.67843303925;12946.223226606433;13004.609861704164;13025.609231723063;9701.369410988264;10163.23775716839;10362.792744144925;10442.947785261025;10547.103496202908;9341.11259430353;9885.209183265466;9890.653827116017;9930.453825039693;9991.500424978867;9077.183053525214;9317.673881414117;9331.67339143154;9333.719988400358;9357.438553686801;6358.936410635834;6453.9354606453335;6488.870222595616;6525.3148419417175;6656.567323123982;6664.233613134357;7017.122859642544;7139.607321597362;7143.35709786101;7299.671514781741 17:10:52 INFO - PID 24087 | |4;prototype.html;499.4481098386283;501.1880753179848;525.8005039335642;529.5948599321518;533.1895518811407;6128.632282063074;6253.656048917308;6264.93496105662;6268.6865656717155;6285.717142728577;5942.851428714284;6108.6945652717295;6132;6185.628862268267;6197.287311959126;5070.594352451813;5156.716380599066;5162.199859021839;5163.922541161885;5195.116830138885;4930.186519224324;5148.5623721983675;5151.381834179903;5190.325257716491;5212.322398088243;5098.235264710286;5098.515641014116;5117.539421452068;5126.666766660173;5147.047796157723;5120.487951204887;5146.485351464842;5149.485051494858;5151.471242199105;5200.375954885438;4738.64460165489;4762.547557981986;4763.332833508279;4768.499307572724;4779.330893674888;6063.151158837766;6073.18012068374;6075.939240607581;6093.695315234265;6110.694465276719;5887.882242355172;5908.852278693024;5913.954313528537;5937.139114828369;5961.880762384728;6418.711157997855;6495;6512.413882750528;6559.60642361455;6625.17185351831;5177.508136727005;5188.792448302063;5209.1665333546825;5217.8173763918085;5236.450172731885;6839.62382068986;6843.486738494583;6857.3313277396355;6966.442684585221;6992.825179370557;5406.216098665672;5428.45715428454;5441.891162176735;5448.564114870801;5457.836264912059;5440.646357986719;5445;5545.889082218333;5591.580631452576;5592.888142237214;5913.048693930992;5980.372060933626;6000.159977603139;6018.398160184034;6023.578349515579;6411.519136064814;6503.187101612299;6530.934690653127;6562.8359291018105;6572.211334639778;1785.276962830056;1827.9451616451527;1863.8229368209998;1880.219708820824;1890.0360815983672;1415.575327401796;1442.005016538585;1446.168453139449;1471.830739464954;1490.3293517916982;5636.605437619327;5637.8590535236945;5711.685857277889;5725.77096916127;5790.594658373958;6507.219133703986;6643;6676.132102826601;6717;6774.085498457645;5776.913346299809;5785.27684039495;5831.241938548046;5837.182794408786;5866.413358664185;3559.341521818472;3572.499850020999;3586.8923932282073;3599.5140656011627;3616.0959760059986;6449.419552240321;6538.346165383424;6542.149520562297;6570.605763654196;6573.244076931214;6718.563293385914;6777.796666100025;6791.966040169867;6822.147231596051;6909.861802763917;6408.743650253938;6443.645599491885;6445.16212892321;6453.611853776804;6455.935440645721;6613.371729685672;6630.668466576748;6638.871391863491;6644.933550664431;6694.4644428444635;6559.508036897157;6587.736490540325;6589.077529145828;6630.933690663224;6667.0998115819775;6266.185395898687;6390.169277993831;6459.935400645933;6466.418022378009;6509.902351464637;5000.874978125576;5030.3963524377305;5036.823711170092;5060.696358218519;5065.13892638245;6397.368670989054;6534.705938232886;6603.603783772989;6635.469162467088;6764.729410823512;6203.2556093269095;6286.339934306832;6363.5227357947415;6370;6468.900286951323;6367.363263673596;6367.649779261999;6401.487880969418;6475.287718351072;6479.708413121515;6279.905801412891;6359.841003974938;6413.743450261937;6432.9678351607945;6440.581362211441;6431.234569135317;6495.9025614614875;6537.70580323877;6555.180602424697;6619.834504137435;6276.309605943434;6284.214473190851;6290.1508296381235;6323.241211054703;6395.1046853441485 17:10:52 INFO - PID 24087 | |5;yui.html;905.1808113657142;920.4983284110159;927.4249965021684;941.7551436626475;948.0756262643923;16012.359505619776;16658.50024499264;16680.91659541702;16777.077260750655;16791.412300569482;16170.434034808784;18429.17068731907;19606.90196549019;21137;21237.57524849506;1044.2690116918168;1060.4379678770265;1065.7708592652577;1072.7264547540367;1073.581303291717;993.7068564773409;1074.8387741838749;1075.0593230922943;1077.466654006264;1077.6551503518876;1008.0765779240226;1087.798757229915;1089.4171618184273;1096.3915027159924;1099.769048499816;1072.7639919217759;1081.1891081688734;1084.7071290751453;1085.7177133945152;1085.7557049663842;748.023828903281;768.0629631849135;790.695582200851;790.9011373578303;791.7426836278175;17286.481405557854;17540.561485962826;17585.648287034186;17650.646987060187;18744.90627546867;19881.105350259273;19910.3031393902;20045.298414555567;20613.79386206134;20680.689789653166;15795.842041579552;15801.683966320608;16130.838691613168;16130.919345403316;16145.354185832553;3567.1795487037866;3582.7133829293853;3583.964160358389;3584.2473080653094;3584.6773790358734;118089;121248;125093;125446.37276813648;126666;15756.68486630261;15936.123513206885;16008.679826403406;16010.9199454002;16053.197340132947;28605.284867878054;30076;30472.390552188834;30508.54237186444;30512.389752204832;8079.5960201989665;8448.873266901;8484.703035393732;8523.147685231428;8526.147385261424;4074.2869997750277;4142.150859073882;4170.082581831992;4176.853810116631;4183.267928112568;5111.897762044739;5126.384833819965;5176.352955880515;5223.738813059332;5231.032259032015;1015.4821041269006;1035.13566172247;1052.6631477927142;1058.2909450668071;1060.745421098946;642.3415998601471;657.2572992518519;657.4247533408268;659.4856012310405;679.6975345971094;11470.827937580943;11983.16117871758;12265.448054837554;12721;12805.743885122245;665.4977671435921;672.237010992527;695.6730336741723;712.5760172697237;717.3400471566172;5248.950209958024;5291.601770130257;5292.512399657403;5304.443033481506;5454.236406903036;101871.4906425478;102844.48577757063;103931.4803425978;106884;107863.46068269608;74599;87383;91059.08940910638;93850;96506;71213.2878671217;78320;79607.60196199098;80437.59781201174;82262.17737822665;12782.105252632227;12992.805107923577;13016.414261358452;13106;13249.867501324863;36747.63252367442;37403.25193496169;37911;37941.430878536295;38244.61755382522;43968;47173.29240061333;47250;47717.52282477131;47829;17644.558886027953;17700.46898593044;18034.819651803315;18180;18232.81767182311;19396.612067758848;20195.293164739163;20515.281965131147;20563.383098507067;20809.37571872846;18735.437936861916;19209.135588898254;19459.221631134595;19565.217391304188;19580.510487237934;17648.94106353623;18103.366382176562;18224;18325.175367108244;18484.075796210403;17454.91272543629;17506.387276445264;17596.73604895953;17674.64650706953;17723.379681711078;12943.482260709467;13017.739645207232;13627.386767595284;13826.516071937434;13836.100653457494;13164.47342106305;13936.163830170222;14060.507882224074;14345.282735862957;14557.12657240569 17:10:52 INFO - PID 24087 | __end_tp_report 17:10:52 INFO - PID 24087 | __start_cc_report 17:10:52 INFO - PID 24087 | _x_x_mozilla_cycle_collect,370 17:10:52 INFO - PID 24087 | __end_cc_report 17:10:52 INFO - PID 24087 | __startTimestamp1500941452883__endTimestamp 17:10:52 INFO - PID 24087 | 17:10:52 INFO - PID 24087 | ------- Summary: start ------- 17:10:52 INFO - PID 24087 | Number of tests: 6 17:10:52 INFO - PID 24087 | 17:10:52 INFO - PID 24087 | [#0] dojo.html Cycles:165 Average:6036.29 Median:6275.28 stddev:696.88 (11.1%) stddev-sans-first:660.88 17:10:52 INFO - PID 24087 | Values: 3137.4 3141.6 3149.5 3187.8 3218.0 5911.4 5974.4 6025.3 6065.2 6102.3 5990.4 6032.0 6065.5 6075.4 6084.8 5523.8 5527.3 5627.7 5644.1 5669.1 5376.1 5593.9 5632.2 5676.7 5697.3 5511.1 5543.3 5547.4 5605.0 5639.7 5551.4 5576.2 5625.2 5639.7 5650.6 5446.4 5506.4 5527.1 5563.7 5584.3 5995.9 6009.2 6016.9 6080.9 6107.0 6500.6 6526.2 6569.9 6602.0 6610.4 6475.2 6557.8 6558.1 6616.1 6653.1 6038.7 6125.5 6136.0 6136.6 6141.4 6632.0 6647.8 6743.1 6743.6 6755.3 6362.9 6417.3 6430.3 6450.1 6486.9 6520.1 6594.9 6624.4 6626.8 6627.0 6468.3 6488.7 6530.6 6543.2 6601.7 6367.1 6462.5 6504.7 6550.7 6570.9 5316.1 5368.1 5379.2 5388.1 5390.5 4534.7 4540.7 4585.9 4603.2 4632.7 5758.4 5781.7 5808.2 5817.2 5821.6 6529.6 6566.9 6593.3 6669.6 6688.0 5636.7 5681.7 5715.3 5806.7 5809.6 5766.7 5862.6 5865.6 5868.9 5891.4 6339.2 6364.5 6432.3 6454.6 6472.3 6449.5 6578.5 6587.2 6658.2 6672.4 6339.3 6356.4 6359.9 6360.8 6366.0 6421.3 6474.9 6481.5 6525.4 6538.2 6518.3 6525.1 6544.8 6643.3 6687.6 6275.3 6325.7 6376.6 6382.6 6438.1 6203.8 6225.9 6242.5 6338.7 6369.9 6222.8 6369.3 6382.9 6388.8 6399.6 6392.0 6406.1 6460.2 6528.6 6534.5 6076.5 6181.2 6197.6 6289.2 6293.9 17:10:52 INFO - PID 24087 | 17:10:52 INFO - PID 24087 | [#1] ext.html Cycles:180 Average:38524.10 Median:34929.48 stddev:53856.89 (154.2%) stddev-sans-first:53933.59 17:10:52 INFO - PID 24087 | Values: 828.0 857.5 887.0 896.8 1157.5 31309.7 41848.4 42574.4 42654.8 42666.6 43303.0 43412.1 43452.6 43517.0 43629.3 7210.0 7567.7 7694.5 7722.3 7814.3 7586.4 7643.4 7677.4 7679.3 7712.8 7629.2 7749.1 7750.7 7757.5 7758.8 7677.9 7680.1 7696.3 7721.1 7732.9 7585.1 7717.1 7719.5 7721.0 7721.5 39261.2 39627.2 39641.0 39725.2 39754.4 3534.1 3577.1 3582.1 3587.4 3587.6 32287.7 32323.0 32352.0 32538.2 32606.0 4874.9 4939.2 4955.9 4989.2 5016.1 184637.1 186328.0 186642.0 186820.0 187082.1 48999.3 49040.0 49273.3 49379.0 49523.8 52017.5 52028.5 52111.5 52127.7 52237.2 16431.3 16748.7 16753.5 16754.7 16779.8 11202.6 11242.2 11275.1 11308.3 13829.5 15974.2 16028.1 16082.9 16085.1 16178.1 6274.0 6326.3 6337.4 6340.8 6485.5 1015.3 1024.4 1028.7 1034.6 1049.1 23404.4 24565.9 24582.1 29550.3 30445.5 1062.4 1097.4 1102.1 1110.9 1121.6 12251.6 15979.3 16133.5 16179.8 16587.3 230629.0 232190.0 232418.0 232512.0 233739.0 58263.7 58579.1 58941.7 58957.7 59005.4 1445.5 1463.9 1477.8 1483.6 1514.0 27558.9 28079.7 28164.2 28290.9 28329.6 38311.0 38674.8 38700.4 38756.0 38803.8 202151.0 202467.0 202511.0 203965.0 204185.0 30918.5 31710.7 34829.0 34844.7 35014.3 43279.8 43344.0 43868.8 44115.6 44301.1 30051.5 31544.8 31989.2 32066.5 32241.0 30296.0 31777.5 32312.2 32320.0 34537.1 38178.6 38468.0 38717.0 38853.0 39153.8 32960.5 33851.2 34058.8 34171.5 34292.0 23909.4 24557.9 24902.0 25240.9 25401.5 17:10:52 INFO - PID 24087 | 17:10:52 INFO - PID 24087 | [#2] jquery.html Cycles:180 Average:34990.03 Median:23716.59 stddev:82983.27 (349.9%) stddev-sans-first:83175.86 17:10:52 INFO - PID 24087 | Values: 584.6 588.8 594.6 600.4 611.3 22769.7 22947.9 23698.5 23734.6 23778.4 26027.1 26433.2 26528.2 26566.7 26846.3 6602.6 6801.8 6804.6 6816.1 6819.6 6114.4 6310.7 6380.9 6644.8 6708.3 6384.6 6386.1 6391.0 6393.2 6397.6 6314.4 6341.9 6381.7 6396.5 6397.8 5849.1 5885.6 5893.6 5903.0 5917.3 29404.0 30185.0 30406.5 30468.8 30821.2 1938.2 1990.5 1993.7 1995.3 1998.3 19164.1 19428.2 19437.4 19492.6 19593.7 2271.3 2289.4 2307.1 2314.2 2314.9 134020.0 135483.0 136659.3 136784.0 139263.0 13844.6 14866.0 14968.6 15128.2 15818.0 24105.9 24139.8 24153.2 24160.9 24221.5 9776.2 9799.9 9802.7 9983.1 10024.3 8509.4 8937.2 9106.3 9106.5 9164.5 8310.0 9115.6 9298.8 9540.0 9684.7 2651.9 2665.7 2725.4 2754.3 2839.4 947.6 948.7 951.1 987.7 998.3 18939.9 19546.8 19733.5 19815.0 20486.0 993.8 1016.2 1019.1 1044.2 1046.6 10651.4 10671.4 10719.2 11228.8 11235.9 485782.0 490575.0 494045.0 495341.0 498420.0 113833.0 117746.4 119341.0 119871.0 119990.0 1227.8 1239.4 1286.5 1295.0 1300.0 16874.7 17535.9 17703.6 18107.2 18320.6 52915.5 54271.5 54504.9 54746.5 54915.0 70482.0 70660.6 71200.6 71615.6 71927.0 12664.0 13282.8 14185.4 14301.0 14725.3 22453.9 22907.4 23423.3 24069.4 24404.0 19241.9 19619.4 19628.5 19637.4 19857.8 15986.8 17535.0 17764.9 18092.8 18131.0 19245.3 20193.7 20208.6 20245.8 20306.5 14945.1 15138.4 15238.1 15251.9 15268.5 18438.4 19689.1 19723.1 19752.0 19818.6 17:10:52 INFO - PID 24087 | 17:10:52 INFO - PID 24087 | [#3] mootools.html Cycles:180 Average:8501.69 Median:2628.74 stddev:5754.74 (218.9%) stddev-sans-first:5745.75 17:10:52 INFO - PID 24087 | Values: 1343.8 1370.2 1396.0 1426.5 1428.3 13435.9 13444.7 14101.0 14106.6 14115.4 14062.9 14432.7 14441.7 14449.0 14451.1 2698.7 2755.4 2759.9 2761.3 2761.8 2636.9 2661.4 2698.9 2699.3 2699.4 2549.8 2620.6 2637.8 2675.9 2699.6 2570.8 2579.9 2592.8 2596.5 2597.1 2530.9 2549.7 2571.1 2571.2 2578.1 13524.6 13781.0 13797.5 13798.7 13816.4 7392.3 7649.0 7684.0 7689.0 7691.1 4692.6 4933.7 4940.8 4985.9 5099.1 1817.7 1827.1 1848.6 1863.9 1899.1 21148.5 21655.5 21676.3 21766.0 21767.9 6620.2 6674.2 6679.2 6857.4 6906.2 17537.4 17540.3 17589.0 17618.0 17649.0 7417.3 7660.8 7663.6 7664.1 7684.3 5823.7 5973.3 6176.4 6226.7 6248.5 5243.7 5355.4 5439.3 5459.3 5486.9 1669.6 1676.9 1700.0 1718.5 1725.1 868.1 871.8 878.5 905.1 911.6 6764.2 7059.2 7116.7 7174.8 7176.1 698.8 699.0 702.3 713.0 723.1 4407.3 4965.8 5052.0 5097.9 5130.1 17695.6 17796.9 18167.1 18275.0 18367.8 17862.5 18038.8 18775.3 18951.3 19144.7 10574.8 10624.6 10711.0 10726.0 10779.2 7438.9 7498.6 7512.8 7654.0 7664.2 15861.8 15933.0 16000.8 16154.1 16155.5 16500.0 16506.6 16626.6 16867.9 16872.2 11131.8 11574.5 11578.9 11584.0 11586.5 12443.5 12862.7 12946.2 13004.6 13025.6 9701.4 10163.2 10362.8 10442.9 10547.1 9341.1 9885.2 9890.7 9930.5 9991.5 9077.2 9317.7 9331.7 9333.7 9357.4 6358.9 6453.9 6488.9 6525.3 6656.6 6664.2 7017.1 7139.6 7143.4 7299.7 17:10:52 INFO - PID 24087 | 17:10:52 INFO - PID 24087 | [#4] prototype.html Cycles:180 Average:5566.96 Median:6109.69 stddev:1485.41 (24.3%) stddev-sans-first:1440.06 17:10:52 INFO - PID 24087 | Values: 499.4 501.2 525.8 529.6 533.2 6128.6 6253.7 6264.9 6268.7 6285.7 5942.9 6108.7 6132.0 6185.6 6197.3 5070.6 5156.7 5162.2 5163.9 5195.1 4930.2 5148.6 5151.4 5190.3 5212.3 5098.2 5098.5 5117.5 5126.7 5147.0 5120.5 5146.5 5149.5 5151.5 5200.4 4738.6 4762.5 4763.3 4768.5 4779.3 6063.2 6073.2 6075.9 6093.7 6110.7 5887.9 5908.9 5914.0 5937.1 5961.9 6418.7 6495.0 6512.4 6559.6 6625.2 5177.5 5188.8 5209.2 5217.8 5236.5 6839.6 6843.5 6857.3 6966.4 6992.8 5406.2 5428.5 5441.9 5448.6 5457.8 5440.6 5445.0 5545.9 5591.6 5592.9 5913.0 5980.4 6000.2 6018.4 6023.6 6411.5 6503.2 6530.9 6562.8 6572.2 1785.3 1827.9 1863.8 1880.2 1890.0 1415.6 1442.0 1446.2 1471.8 1490.3 5636.6 5637.9 5711.7 5725.8 5790.6 6507.2 6643.0 6676.1 6717.0 6774.1 5776.9 5785.3 5831.2 5837.2 5866.4 3559.3 3572.5 3586.9 3599.5 3616.1 6449.4 6538.3 6542.1 6570.6 6573.2 6718.6 6777.8 6792.0 6822.1 6909.9 6408.7 6443.6 6445.2 6453.6 6455.9 6613.4 6630.7 6638.9 6644.9 6694.5 6559.5 6587.7 6589.1 6630.9 6667.1 6266.2 6390.2 6459.9 6466.4 6509.9 5000.9 5030.4 5036.8 5060.7 5065.1 6397.4 6534.7 6603.6 6635.5 6764.7 6203.3 6286.3 6363.5 6370.0 6468.9 6367.4 6367.6 6401.5 6475.3 6479.7 6279.9 6359.8 6413.7 6433.0 6440.6 6431.2 6495.9 6537.7 6555.2 6619.8 6276.3 6284.2 6290.2 6323.2 6395.1 17:10:52 INFO - PID 24087 | 17:10:52 INFO - PID 24087 | [#5] yui.html Cycles:180 Average:22122.85 Median:18740.17 stddev:29731.20 (158.6%) stddev-sans-first:29771.92 17:10:52 INFO - PID 24087 | Values: 905.2 920.5 927.4 941.8 948.1 16012.4 16658.5 16680.9 16777.1 16791.4 16170.4 18429.2 19606.9 21137.0 21237.6 1044.3 1060.4 1065.8 1072.7 1073.6 993.7 1074.8 1075.1 1077.5 1077.7 1008.1 1087.8 1089.4 1096.4 1099.8 1072.8 1081.2 1084.7 1085.7 1085.8 748.0 768.1 790.7 790.9 791.7 17286.5 17540.6 17585.6 17650.6 18744.9 19881.1 19910.3 20045.3 20613.8 20680.7 15795.8 15801.7 16130.8 16130.9 16145.4 3567.2 3582.7 3584.0 3584.2 3584.7 118089.0 121248.0 125093.0 125446.4 126666.0 15756.7 15936.1 16008.7 16010.9 16053.2 28605.3 30076.0 30472.4 30508.5 30512.4 8079.6 8448.9 8484.7 8523.1 8526.1 4074.3 4142.2 4170.1 4176.9 4183.3 5111.9 5126.4 5176.4 5223.7 5231.0 1015.5 1035.1 1052.7 1058.3 1060.7 642.3 657.3 657.4 659.5 679.7 11470.8 11983.2 12265.4 12721.0 12805.7 665.5 672.2 695.7 712.6 717.3 5249.0 5291.6 5292.5 5304.4 5454.2 101871.5 102844.5 103931.5 106884.0 107863.5 74599.0 87383.0 91059.1 93850.0 96506.0 71213.3 78320.0 79607.6 80437.6 82262.2 12782.1 12992.8 13016.4 13106.0 13249.9 36747.6 37403.3 37911.0 37941.4 38244.6 43968.0 47173.3 47250.0 47717.5 47829.0 17644.6 17700.5 18034.8 18180.0 18232.8 19396.6 20195.3 20515.3 20563.4 20809.4 18735.4 19209.1 19459.2 19565.2 19580.5 17648.9 18103.4 18224.0 18325.2 18484.1 17454.9 17506.4 17596.7 17674.6 17723.4 12943.5 13017.7 13627.4 13826.5 13836.1 13164.5 13936.2 14060.5 14345.3 14557.1 17:10:52 INFO - PID 24087 | -------- Summary: end -------- 17:10:52 INFO - PID 24087 | 17:10:53 INFO - TEST-INFO | 24087: exit 0 17:10:53 INFO - TEST-OK | dromaeo_css | took 1112520ms 17:10:53 INFO - TEST-START | kraken 17:10:53 INFO - Initialising browser for kraken test... 17:10:53 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41488/getInfo.html -profile /tmp/tmp9ZiX5E/profile 17:10:53 INFO - TEST-INFO | started process 24441 (/builds/slave/test/build/application/firefox/firefox http://localhost:41488/getInfo.html) 17:10:59 INFO - TEST-INFO | 24441: exit 0 17:10:59 INFO - Browser initialized. 17:10:59 INFO - Running cycle 1/1 for kraken test... 17:10:59 INFO - TEST-INFO | started process 24648 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9ZiX5E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:11:10 INFO - PID 24648 | RSS: Main: 174043136 17:11:10 INFO - PID 24648 | 17:11:13 INFO - PID 24648 | Cycle 1(1): loaded http://localhost:41488/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41488/tests/kraken/driver.html?testName=audio-beat-detection) 17:11:14 INFO - PID 24648 | RSS: Main: 179732480 17:11:14 INFO - PID 24648 | 17:11:16 INFO - PID 24648 | Cycle 1(1): loaded http://localhost:41488/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41488/tests/kraken/driver.html?testName=audio-dft) 17:11:17 INFO - PID 24648 | RSS: Main: 179896320 17:11:17 INFO - PID 24648 | 17:11:20 INFO - PID 24648 | Cycle 1(1): loaded http://localhost:41488/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41488/tests/kraken/driver.html?testName=audio-fft) 17:11:21 INFO - PID 24648 | RSS: Main: 174579712 17:11:21 INFO - PID 24648 | 17:11:23 INFO - PID 24648 | Cycle 1(1): loaded http://localhost:41488/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41488/tests/kraken/driver.html?testName=audio-oscillator) 17:11:23 INFO - PID 24648 | RSS: Main: 175665152 17:11:23 INFO - PID 24648 | 17:11:25 INFO - PID 24648 | Cycle 1(1): loaded http://localhost:41488/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41488/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:11:26 INFO - PID 24648 | RSS: Main: 176254976 17:11:26 INFO - PID 24648 | 17:11:29 INFO - PID 24648 | Cycle 1(1): loaded http://localhost:41488/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41488/tests/kraken/driver.html?testName=imaging-darkroom) 17:11:30 INFO - PID 24648 | RSS: Main: 178163712 17:11:30 INFO - PID 24648 | 17:11:33 INFO - PID 24648 | Cycle 1(1): loaded http://localhost:41488/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41488/tests/kraken/driver.html?testName=imaging-desaturate) 17:11:34 INFO - PID 24648 | RSS: Main: 178307072 17:11:34 INFO - PID 24648 | 17:11:37 INFO - PID 24648 | Cycle 1(1): loaded http://localhost:41488/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41488/tests/kraken/driver.html?testName=json-parse-financial) 17:11:37 INFO - PID 24648 | RSS: Main: 178880512 17:11:37 INFO - PID 24648 | 17:11:39 INFO - PID 24648 | Cycle 1(1): loaded http://localhost:41488/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41488/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:11:40 INFO - PID 24648 | RSS: Main: 178872320 17:11:40 INFO - PID 24648 | 17:11:41 INFO - PID 24648 | Cycle 1(1): loaded http://localhost:41488/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41488/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:11:42 INFO - PID 24648 | RSS: Main: 178966528 17:11:42 INFO - PID 24648 | 17:11:44 INFO - PID 24648 | Cycle 1(1): loaded http://localhost:41488/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41488/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:11:45 INFO - PID 24648 | RSS: Main: 175407104 17:11:45 INFO - PID 24648 | 17:11:47 INFO - PID 24648 | Cycle 1(1): loaded http://localhost:41488/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41488/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:11:48 INFO - PID 24648 | RSS: Main: 176304128 17:11:48 INFO - PID 24648 | 17:11:51 INFO - PID 24648 | Cycle 1(1): loaded http://localhost:41488/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41488/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:11:52 INFO - PID 24648 | RSS: Main: 176463872 17:11:52 INFO - PID 24648 | 17:11:54 INFO - PID 24648 | Cycle 1(1): loaded http://localhost:41488/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41488/tests/kraken/driver.html?testName=ai-astar) 17:11:54 INFO - PID 24648 | RSS: Main: 178225152 17:11:54 INFO - PID 24648 | 17:11:54 INFO - PID 24648 | __start_tp_report 17:11:54 INFO - PID 24648 | _x_x_mozilla_page_load 17:11:54 INFO - PID 24648 | _x_x_mozilla_page_load_details 17:11:54 INFO - PID 24648 | |i|pagename|runs| 17:11:54 INFO - PID 24648 | |0;ai-astar;99;111;102;109;109;112;112;101;110;109 17:11:54 INFO - PID 24648 | |1;audio-beat-detection;148;117;140;168;119;149;150;118;165;126 17:11:54 INFO - PID 24648 | |2;audio-dft;162;162;163;164;165;161;166;167;168;166 17:11:54 INFO - PID 24648 | |3;audio-fft;74;75;74;182;75;74;76;89;94;84 17:11:54 INFO - PID 24648 | |4;audio-oscillator;80;81;135;80;81;80;126;80;81;126 17:11:54 INFO - PID 24648 | |5;imaging-gaussian-blur;114;113;115;114;115;114;114;114;113;115 17:11:54 INFO - PID 24648 | |6;imaging-darkroom;151;151;151;151;152;151;152;152;151;157 17:11:54 INFO - PID 24648 | |7;imaging-desaturate;94;94;95;94;94;93;94;95;94;94 17:11:54 INFO - PID 24648 | |8;json-parse-financial;55;54;55;55;62;56;56;56;54;54 17:11:54 INFO - PID 24648 | |9;json-stringify-tinderbox;54;54;54;54;55;53;54;54;58;55 17:11:54 INFO - PID 24648 | |10;stanford-crypto-aes;87;78;77;88;78;79;78;88;77;84 17:11:54 INFO - PID 24648 | |11;stanford-crypto-ccm;131;126;127;127;138;127;128;135;136;161 17:11:54 INFO - PID 24648 | |12;stanford-crypto-pbkdf2;176;187;173;176;176;179;179;177;176;173 17:11:54 INFO - PID 24648 | |13;stanford-crypto-sha256-iterative;68;68;68;69;66;70;71;68;67;67 17:11:54 INFO - PID 24648 | __end_tp_report 17:11:54 INFO - PID 24648 | __start_cc_report 17:11:54 INFO - PID 24648 | _x_x_mozilla_cycle_collect,1001 17:11:54 INFO - PID 24648 | __end_cc_report 17:11:54 INFO - PID 24648 | __startTimestamp1500941514424__endTimestamp 17:11:54 INFO - PID 24648 | 17:11:54 INFO - PID 24648 | ------- Summary: start ------- 17:11:54 INFO - PID 24648 | Number of tests: 14 17:11:54 INFO - PID 24648 | 17:11:54 INFO - PID 24648 | [#0] ai-astar Cycles:10 Average:107.40 Median:110.50 stddev:4.84 (4.4%) stddev-sans-first:4.06 17:11:54 INFO - PID 24648 | Values: 99.0 111.0 102.0 109.0 109.0 112.0 112.0 101.0 110.0 109.0 17:11:54 INFO - PID 24648 | 17:11:54 INFO - PID 24648 | [#1] audio-beat-detection Cycles:10 Average:140.00 Median:148.50 stddev:19.16 (12.9%) stddev-sans-first:20.10 17:11:54 INFO - PID 24648 | Values: 148.0 117.0 140.0 168.0 119.0 149.0 150.0 118.0 165.0 126.0 17:11:54 INFO - PID 24648 | 17:11:54 INFO - PID 24648 | [#2] audio-dft Cycles:10 Average:164.40 Median:165.50 stddev:2.37 (1.4%) stddev-sans-first:2.35 17:11:54 INFO - PID 24648 | Values: 162.0 162.0 163.0 164.0 165.0 161.0 166.0 167.0 168.0 166.0 17:11:54 INFO - PID 24648 | 17:11:54 INFO - PID 24648 | [#3] audio-fft Cycles:10 Average:89.70 Median:75.50 stddev:33.22 (44.0%) stddev-sans-first:34.74 17:11:54 INFO - PID 24648 | Values: 74.0 75.0 74.0 182.0 75.0 74.0 76.0 89.0 94.0 84.0 17:11:54 INFO - PID 24648 | 17:11:54 INFO - PID 24648 | [#4] audio-oscillator Cycles:10 Average:95.00 Median:80.00 stddev:23.59 (29.5%) stddev-sans-first:24.39 17:11:54 INFO - PID 24648 | Values: 80.0 81.0 135.0 80.0 81.0 80.0 126.0 80.0 81.0 126.0 17:11:54 INFO - PID 24648 | 17:11:54 INFO - PID 24648 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 17:11:54 INFO - PID 24648 | Values: 114.0 113.0 115.0 114.0 115.0 114.0 114.0 114.0 113.0 115.0 17:11:54 INFO - PID 24648 | 17:11:54 INFO - PID 24648 | [#6] imaging-darkroom Cycles:10 Average:151.90 Median:151.50 stddev:1.85 (1.2%) stddev-sans-first:1.94 17:11:54 INFO - PID 24648 | Values: 151.0 151.0 151.0 151.0 152.0 151.0 152.0 152.0 151.0 157.0 17:11:54 INFO - PID 24648 | 17:11:54 INFO - PID 24648 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 17:11:54 INFO - PID 24648 | Values: 94.0 94.0 95.0 94.0 94.0 93.0 94.0 95.0 94.0 94.0 17:11:54 INFO - PID 24648 | 17:11:54 INFO - PID 24648 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:55.50 stddev:2.36 (4.3%) stddev-sans-first:2.49 17:11:54 INFO - PID 24648 | Values: 55.0 54.0 55.0 55.0 62.0 56.0 56.0 56.0 54.0 54.0 17:11:54 INFO - PID 24648 | 17:11:54 INFO - PID 24648 | [#9] json-stringify-tinderbox Cycles:10 Average:54.50 Median:54.00 stddev:1.35 (2.5%) stddev-sans-first:1.42 17:11:54 INFO - PID 24648 | Values: 54.0 54.0 54.0 54.0 55.0 53.0 54.0 54.0 58.0 55.0 17:11:54 INFO - PID 24648 | 17:11:54 INFO - PID 24648 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:81.50 stddev:4.77 (5.8%) stddev-sans-first:4.60 17:11:54 INFO - PID 24648 | Values: 87.0 78.0 77.0 88.0 78.0 79.0 78.0 88.0 77.0 84.0 17:11:54 INFO - PID 24648 | 17:11:54 INFO - PID 24648 | [#11] stanford-crypto-ccm Cycles:10 Average:133.60 Median:133.00 stddev:10.56 (7.9%) stddev-sans-first:11.16 17:11:54 INFO - PID 24648 | Values: 131.0 126.0 127.0 127.0 138.0 127.0 128.0 135.0 136.0 161.0 17:11:54 INFO - PID 24648 | 17:11:54 INFO - PID 24648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.20 Median:176.50 stddev:3.99 (2.3%) stddev-sans-first:4.21 17:11:54 INFO - PID 24648 | Values: 176.0 187.0 173.0 176.0 176.0 179.0 179.0 177.0 176.0 173.0 17:11:54 INFO - PID 24648 | 17:11:54 INFO - PID 24648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:1.48 (2.2%) stddev-sans-first:1.56 17:11:54 INFO - PID 24648 | Values: 68.0 68.0 68.0 69.0 66.0 70.0 71.0 68.0 67.0 67.0 17:11:54 INFO - PID 24648 | -------- Summary: end -------- 17:11:54 INFO - PID 24648 | 17:11:55 INFO - PID 24648 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:11:55 INFO - TEST-INFO | 24648: exit 0 17:11:55 INFO - TEST-OK | kraken | took 61661ms 17:11:55 INFO - SUITE-END | took 1174s 17:11:55 INFO - Completed test suite (00:19:34) 17:11:55 INFO - javascript benchmark 17:11:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8449.151895298799, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3137.435261652902, 3141.5758872552196, 3149.5118256670216, 3187.7927934684258, 3217.967820321796, 5911.379305172959, 5974.402559744023, 6025.3070896846875, 6065.211522502074, 6102.328743838174, 5990.430909063632, 6032.0, 6065.454109130177, 6075.422834830695, 6084.787032453865, 5523.751431185597, 5527.2538207341895, 5627.6904770237625, 5644.068728659766, 5669.0646043402785, 5376.1398176291805, 5593.860153496154, 5632.183333416652, 5676.716164191795, 5697.344805347397, 5511.090670039439, 5543.334799824007, 5547.417521160261, 5604.971975140098, 5639.718014099279, 5551.444855514456, 5576.191452239443, 5625.212470254168, 5639.718014099279, 5650.604457687922, 5446.428125046853, 5506.421825708283, 5527.143292789624, 5563.749631266603, 5584.329880414376, 5995.880082398371, 6009.248843894513, 6016.939830601682, 6080.908786368208, 6107.0, 6500.609963402211, 6526.216853977506, 6569.93430065698, 6601.966990165067, 6610.405063544256, 6475.222973243241, 6557.770478033293, 6558.081868538408, 6616.106825578533, 6653.135092438, 6038.6678732670125, 6125.540584456184, 6136.048912418582, 6136.60112092717, 6141.416565426322, 6631.966840165768, 6647.833804154838, 6743.055972163901, 6743.561668491532, 6755.256921738604, 6362.872742545123, 6417.294097649255, 6430.292667806538, 6450.096986421905, 6486.870262594722, 6520.0871877937125, 6594.86810263792, 6624.403803657598, 6626.834329141713, 6627.0, 6468.256150542654, 6488.740450382026, 6530.640814755234, 6543.1821022372205, 6601.70292336846, 6367.108604795332, 6462.450691691165, 6504.674766261668, 6550.705218265094, 6570.901436478457, 5316.096263635114, 5368.087425137736, 5379.1662292344745, 5388.08402571556, 5390.51485366311, 4534.682572219979, 4540.727556346564, 4585.862424127282, 4603.194440972817, 4632.745199014019, 5758.424157584208, 5781.739821707949, 5808.215890854765, 5817.243758311477, 5821.592488525763, 6529.640869752209, 6566.934330656728, 6593.274739778621, 6669.599824010575, 6688.0, 5636.746346414421, 5681.659100453903, 5715.31416230055, 5806.738696758656, 5809.564282678816, 5766.682832444172, 5862.648241105548, 5865.589408741433, 5868.882622347529, 5891.381404952418, 6339.175907132043, 6364.522660800366, 6432.292447830641, 6454.6449945252525, 6472.320406357265, 6449.484041276781, 6578.506612004215, 6587.176602924635, 6658.201015877932, 6672.366125218096, 6339.3343698912795, 6356.396142366468, 6359.87280254383, 6360.77737279193, 6365.96817015912, 6421.325760795049, 6474.902876456763, 6481.546291759721, 6525.445337146396, 6538.1827271591055, 6518.250401203923, 6525.0538671893255, 6544.803655890331, 6643.335666433318, 6687.63218022994, 6275.278342990432, 6325.683715814099, 6376.649284289409, 6382.6170429774365, 6438.066480360415, 6203.8138855834395, 6225.937740622536, 6242.500599952084, 6338.651374174465, 6369.90445143314, 6222.81331560054, 6369.299377068426, 6382.872342553216, 6388.776392826228, 6399.616023038632, 6392.0, 6406.071119687526, 6460.160179176865, 6528.608283503005, 6534.509911756542, 6076.483498902643, 6181.227346581677, 6197.628142311476, 6289.245290565162, 6293.874122517433], "value": 5985.619162459202, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [827.9834403311934, 857.5112186053948, 886.9778255543615, 896.7892545251863, 1157.4849192109514, 31309.68690313096, 41848.37227441591, 42574.36138457926, 42654.786726066406, 42666.57333426665, 43303.0, 43412.131757364914, 43452.56547434525, 43517.0, 43629.345559816626, 7209.963950180242, 7567.6972921083225, 7694.5383277003275, 7722.343600793939, 7814.296713295802, 7586.355159811423, 7643.350315223212, 7677.385809135256, 7679.2704693054075, 7712.768616941501, 7629.160792312841, 7749.070111586618, 7750.689972401097, 7757.495762775401, 7758.8448231035345, 7677.884831727529, 7680.11678656956, 7696.307332340089, 7721.112072111723, 7732.922670773305, 7585.12771031333, 7717.073951125901, 7719.536827790294, 7721.03487064117, 7721.53670779755, 39261.21477570433, 39627.20745585101, 39641.0, 39725.20549588992, 39754.403683944765, 3534.0634731796094, 3577.0878426001464, 3582.140286331288, 3587.443946188345, 3587.6232995535356, 32287.677123228936, 32323.0, 32352.0, 32538.18654533632, 32606.0, 4874.8537543873745, 4939.234418665113, 4955.90088198234, 4989.176785830334, 5016.122178618763, 184637.07681461642, 186328.0, 186642.0, 186820.0, 187082.06458967755, 48999.265011024865, 49040.0, 49273.26090108579, 49379.0, 49523.752381237864, 52017.47982520202, 52028.47971520236, 52111.478885210665, 52127.73936130295, 52237.21644175341, 16431.342746290255, 16748.748768768477, 16753.497395078168, 16754.74867876983, 16779.832201677826, 11202.551897924155, 11242.213045086766, 11275.097992160607, 11308.264962777394, 13829.51596694111, 15974.201289935456, 16028.118453484936, 16082.919585401998, 16085.06979162508, 16178.11020393866, 6274.047350169455, 6326.335734747785, 6337.366263373718, 6340.778072767524, 6485.54601177913, 1015.3045164062493, 1024.4058446101244, 1028.711960651019, 1034.591336422109, 1049.1239814754613, 23404.350706603876, 24565.877170614032, 24582.139625113035, 29550.261243468656, 30445.543316850264, 1062.4262898035129, 1097.3635291530893, 1102.0687519046394, 1110.9000189982778, 1121.6466812953893, 12251.632451026484, 15979.342826177139, 16133.515994520183, 16179.838201617833, 16587.336506539603, 230629.0, 232190.0, 232418.0, 232512.0, 233739.0, 58263.70868145717, 58579.12131318034, 58941.70529147327, 58957.705211474524, 59005.40994590085, 1445.4868521674864, 1463.948761793332, 1477.8152730908637, 1483.5771805035297, 1513.9772903406458, 27558.862205689646, 28079.71920280771, 28164.15507534777, 28290.85854570714, 28329.575056374582, 38311.0, 38674.806625967816, 38700.41949370706, 38756.0, 38803.80598096991, 202151.0, 202467.0, 202511.0, 203965.0, 204185.0, 30918.536221956238, 31710.68289317077, 34829.0, 34844.65155348414, 35014.299714005065, 43279.78360108305, 43344.0, 43868.78065609652, 44115.55884441114, 44301.11397772091, 30051.549226762054, 31544.842275788473, 31989.200269993435, 32066.519002215453, 32241.0, 30296.0, 31777.523337149498, 32312.192195195308, 32320.030399088064, 34537.136571585914, 38178.618213817506, 38468.0, 38717.0, 38853.0, 39153.804230979804, 32960.505592415655, 33851.15372115717, 34058.8297058523, 34171.4874276891, 34292.0, 23909.40226494282, 24557.894894730136, 24902.0, 25240.873795630905, 25401.491970160863], "value": 17752.70450410176, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.6462889951579, 588.7733222709261, 594.6432140715569, 600.3906035374096, 611.3428064830307, 22769.658455123164, 22947.885260573716, 23698.52602947942, 23734.64398034031, 23778.40553986149, 26027.089051883187, 26433.207003789918, 26528.204153875366, 26566.734332656666, 26846.328841778966, 6602.636854972987, 6801.7959461216, 6804.557703749265, 6816.147981502312, 6819.5908245505425, 6114.388561143895, 6310.747570097191, 6380.904286435707, 6644.833879153036, 6708.329167083277, 6384.58500197488, 6386.10594516768, 6391.0, 6393.232812062559, 6397.5521713480075, 6314.431701146873, 6341.873162536746, 6381.744730210832, 6396.5202609804455, 6397.776077837277, 5849.064149736065, 5885.646861188299, 5893.616914900518, 5903.0, 5917.349091599921, 29404.0, 30185.0, 30406.54390184149, 30468.84765576158, 30821.22946926345, 1938.185961896007, 1990.5023744063983, 1993.7308463357551, 1995.311617491963, 1998.3005947918257, 19164.137613807412, 19428.22287108514, 19437.4168774937, 19492.610147797106, 19593.706094408597, 2271.261839902022, 2289.381866895945, 2307.14635584833, 2314.247869442438, 2314.93055208344, 134020.0, 135483.0, 136659.31670341684, 136784.0, 139263.0, 13844.584662460142, 14865.993090932801, 14968.625784355478, 15128.243587820565, 15818.0, 24105.879470602536, 24139.758602413753, 24153.15463958753, 24160.87919560391, 24221.51556968851, 9776.1690256329, 9799.902000980042, 9802.705918822447, 9983.101520863012, 10024.348417352849, 8509.361797865186, 8937.195652391316, 9106.27149828012, 9106.453612783254, 9164.541772911327, 8309.95845020771, 9115.635374585076, 9298.814023719488, 9540.0, 9684.661036863818, 2651.9469610608066, 2665.6934452537816, 2725.427660191382, 2754.254214268593, 2839.4321135772516, 947.5688561704408, 948.7248697877676, 951.0876178516231, 987.7234374375042, 998.3011891675711, 18939.90530047341, 19546.804531954782, 19733.506662333268, 19814.997557887815, 20486.0, 993.8445435741492, 1016.2378216337746, 1019.1439191079529, 1044.2429238801808, 1046.5813674530098, 10651.360918344924, 10671.413072280944, 10719.249652524404, 11228.75771485972, 11235.943820280847, 485782.0, 490575.0, 494045.0, 495341.0, 498420.0, 113833.0, 117746.41126794311, 119341.0, 119871.0, 119990.0, 1227.846519185102, 1239.3988915376035, 1286.4854058376536, 1294.9604373112386, 1300.0314765499763, 16874.662506750043, 17535.912320438318, 17703.645927081645, 18107.18517666682, 18320.633587327913, 52915.470845291056, 54271.45728542664, 54504.90990180254, 54746.45253547573, 54915.0, 70482.0, 70660.64669676618, 71200.64399677969, 71615.64192179005, 71927.0, 12664.0, 13282.804547590764, 14185.432582696576, 14301.0, 14725.263736813331, 22453.8773061343, 22907.427314317276, 23423.297301080995, 24069.398265043514, 24404.0, 19241.90379048096, 19619.411417657495, 19628.509287267363, 19637.410877673694, 19857.808531488157, 15986.760198597263, 17535.0, 17764.911175444042, 18092.819071809114, 18131.0, 19245.326413575458, 20193.697094543888, 20208.59582808365, 20245.79754202498, 20306.477014223696, 14945.103293802407, 15138.394464221308, 15238.085714857145, 15251.923740381228, 15268.465603703817, 18438.35465758692, 19689.113989870202, 19723.112459939624, 19752.0, 19818.60362792765], "value": 12041.304116454998, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1343.838739351278, 1370.2395170680275, 1395.9651008724782, 1426.507854790097, 1428.257306200775, 13435.925125989921, 13444.731105377887, 14101.0, 14106.64733381666, 14115.43538258471, 14062.859371406283, 14432.711345773077, 14441.711165776678, 14449.0, 14451.132932024086, 2698.716634753357, 2755.3662657588766, 2759.9172024839286, 2761.254461295449, 2761.7514423701864, 2636.8681565921725, 2661.3878807874203, 2698.932526686829, 2699.311675522739, 2699.392636656756, 2549.79601631869, 2620.6200100985347, 2637.762601365877, 2675.933101672454, 2699.568069108943, 2570.820042597019, 2579.8968041278326, 2592.8185027048116, 2596.545604519202, 2597.116980226732, 2530.911418100376, 2549.668543089405, 2571.1386685460207, 2571.241483762276, 2578.1234380310784, 13524.59426217215, 13781.0, 13797.51708690191, 13798.65503362414, 13816.378262978089, 7392.260773922619, 7649.0, 7684.039495063117, 7688.961555192244, 7691.115521714963, 4692.601128904047, 4933.654644174909, 4940.802367905279, 4985.9252111218, 5099.107656160194, 1817.7000794868832, 1827.0864567716142, 1848.5563464768493, 1863.8508919286423, 1899.116910636547, 21148.47128821792, 21655.45861353479, 21676.34970950874, 21766.0, 21767.891160544095, 6620.172478440195, 6674.199096108498, 6679.198496180489, 6857.382835544825, 6906.171259448798, 17537.386191483238, 17540.298388064333, 17589.0, 17618.0, 17649.0, 7417.258274172647, 7660.80847978805, 7663.616819159131, 7664.080310362792, 7684.269994350528, 5823.679697616587, 5973.253343332083, 6176.3514830943, 6226.688665566794, 6248.500119990481, 5243.659162154448, 5355.357357117093, 5439.265699130567, 5459.2902922619805, 5486.862828429321, 1669.607642204081, 1676.9496915092566, 1700.0, 1718.518814731877, 1725.1115675427166, 868.0928429790883, 871.7646235516376, 878.5124256037833, 905.1491597897955, 911.6262332443666, 6764.188297404343, 7059.152901651834, 7116.715331386687, 7174.820629484305, 7176.067111275605, 698.769406095987, 698.9934494328152, 702.3257672634328, 712.9500934934608, 723.0961298377028, 4407.338899165151, 4965.751712414437, 5051.974740126349, 5097.898042039138, 5130.102232109441, 17695.557611059827, 17796.911015445097, 18167.091645417677, 18275.0, 18367.81632183688, 17862.46412607624, 18038.819611803978, 18775.34286299973, 18951.336703215322, 19144.712829307573, 10574.83676795552, 10624.575016999388, 10711.0, 10726.034656880762, 10779.245452818228, 7438.940869830759, 7498.625068746432, 7512.774616761506, 7654.043244594426, 7664.195259497673, 15861.841381586037, 15933.0, 16000.759988600414, 16154.1115238663, 16155.515334539983, 16500.0, 16506.58733531671, 16626.58433539171, 16867.91566042162, 16872.156392180586, 11131.775504694315, 11574.537018519502, 11578.942105289756, 11584.0, 11586.47860846247, 12443.502259909865, 12862.67843303925, 12946.223226606433, 13004.609861704164, 13025.609231723063, 9701.369410988264, 10163.23775716839, 10362.792744144925, 10442.947785261025, 10547.103496202908, 9341.11259430353, 9885.209183265466, 9890.653827116017, 9930.453825039693, 9991.500424978867, 9077.183053525214, 9317.673881414117, 9331.67339143154, 9333.719988400358, 9357.438553686801, 6358.936410635834, 6453.9354606453335, 6488.870222595616, 6525.3148419417175, 6656.567323123982, 6664.233613134357, 7017.122859642544, 7139.607321597362, 7143.35709786101, 7299.671514781741], "value": 6217.055433517915, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.4481098386283, 501.1880753179848, 525.8005039335642, 529.5948599321518, 533.1895518811407, 6128.632282063074, 6253.656048917308, 6264.93496105662, 6268.6865656717155, 6285.717142728577, 5942.851428714284, 6108.6945652717295, 6132.0, 6185.628862268267, 6197.287311959126, 5070.594352451813, 5156.716380599066, 5162.199859021839, 5163.922541161885, 5195.116830138885, 4930.186519224324, 5148.5623721983675, 5151.381834179903, 5190.325257716491, 5212.322398088243, 5098.235264710286, 5098.515641014116, 5117.539421452068, 5126.666766660173, 5147.047796157723, 5120.487951204887, 5146.485351464842, 5149.485051494858, 5151.471242199105, 5200.375954885438, 4738.64460165489, 4762.547557981986, 4763.332833508279, 4768.499307572724, 4779.330893674888, 6063.151158837766, 6073.18012068374, 6075.939240607581, 6093.695315234265, 6110.694465276719, 5887.882242355172, 5908.852278693024, 5913.954313528537, 5937.139114828369, 5961.880762384728, 6418.711157997855, 6495.0, 6512.413882750528, 6559.60642361455, 6625.17185351831, 5177.508136727005, 5188.792448302063, 5209.1665333546825, 5217.8173763918085, 5236.450172731885, 6839.62382068986, 6843.486738494583, 6857.3313277396355, 6966.442684585221, 6992.825179370557, 5406.216098665672, 5428.45715428454, 5441.891162176735, 5448.564114870801, 5457.836264912059, 5440.646357986719, 5445.0, 5545.889082218333, 5591.580631452576, 5592.888142237214, 5913.048693930992, 5980.372060933626, 6000.159977603139, 6018.398160184034, 6023.578349515579, 6411.519136064814, 6503.187101612299, 6530.934690653127, 6562.8359291018105, 6572.211334639778, 1785.276962830056, 1827.9451616451527, 1863.8229368209998, 1880.219708820824, 1890.0360815983672, 1415.575327401796, 1442.005016538585, 1446.168453139449, 1471.830739464954, 1490.3293517916982, 5636.605437619327, 5637.8590535236945, 5711.685857277889, 5725.77096916127, 5790.594658373958, 6507.219133703986, 6643.0, 6676.132102826601, 6717.0, 6774.085498457645, 5776.913346299809, 5785.27684039495, 5831.241938548046, 5837.182794408786, 5866.413358664185, 3559.341521818472, 3572.499850020999, 3586.8923932282073, 3599.5140656011627, 3616.0959760059986, 6449.419552240321, 6538.346165383424, 6542.149520562297, 6570.605763654196, 6573.244076931214, 6718.563293385914, 6777.796666100025, 6791.966040169867, 6822.147231596051, 6909.861802763917, 6408.743650253938, 6443.645599491885, 6445.16212892321, 6453.611853776804, 6455.935440645721, 6613.371729685672, 6630.668466576748, 6638.871391863491, 6644.933550664431, 6694.4644428444635, 6559.508036897157, 6587.736490540325, 6589.077529145828, 6630.933690663224, 6667.0998115819775, 6266.185395898687, 6390.169277993831, 6459.935400645933, 6466.418022378009, 6509.902351464637, 5000.874978125576, 5030.3963524377305, 5036.823711170092, 5060.696358218519, 5065.13892638245, 6397.368670989054, 6534.705938232886, 6603.603783772989, 6635.469162467088, 6764.729410823512, 6203.2556093269095, 6286.339934306832, 6363.5227357947415, 6370.0, 6468.900286951323, 6367.363263673596, 6367.649779261999, 6401.487880969418, 6475.287718351072, 6479.708413121515, 6279.905801412891, 6359.841003974938, 6413.743450261937, 6432.9678351607945, 6440.581362211441, 6431.234569135317, 6495.9025614614875, 6537.70580323877, 6555.180602424697, 6619.834504137435, 6276.309605943434, 6284.214473190851, 6290.1508296381235, 6323.241211054703, 6395.1046853441485], "value": 5141.186648932632, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [905.1808113657142, 920.4983284110159, 927.4249965021684, 941.7551436626475, 948.0756262643923, 16012.359505619776, 16658.50024499264, 16680.91659541702, 16777.077260750655, 16791.412300569482, 16170.434034808784, 18429.17068731907, 19606.90196549019, 21137.0, 21237.57524849506, 1044.2690116918168, 1060.4379678770265, 1065.7708592652577, 1072.7264547540367, 1073.581303291717, 993.7068564773409, 1074.8387741838749, 1075.0593230922943, 1077.466654006264, 1077.6551503518876, 1008.0765779240226, 1087.798757229915, 1089.4171618184273, 1096.3915027159924, 1099.769048499816, 1072.7639919217759, 1081.1891081688734, 1084.7071290751453, 1085.7177133945152, 1085.7557049663842, 748.023828903281, 768.0629631849135, 790.695582200851, 790.9011373578303, 791.7426836278175, 17286.481405557854, 17540.561485962826, 17585.648287034186, 17650.646987060187, 18744.90627546867, 19881.105350259273, 19910.3031393902, 20045.298414555567, 20613.79386206134, 20680.689789653166, 15795.842041579552, 15801.683966320608, 16130.838691613168, 16130.919345403316, 16145.354185832553, 3567.1795487037866, 3582.7133829293853, 3583.964160358389, 3584.2473080653094, 3584.6773790358734, 118089.0, 121248.0, 125093.0, 125446.37276813648, 126666.0, 15756.68486630261, 15936.123513206885, 16008.679826403406, 16010.9199454002, 16053.197340132947, 28605.284867878054, 30076.0, 30472.390552188834, 30508.54237186444, 30512.389752204832, 8079.5960201989665, 8448.873266901, 8484.703035393732, 8523.147685231428, 8526.147385261424, 4074.2869997750277, 4142.150859073882, 4170.082581831992, 4176.853810116631, 4183.267928112568, 5111.897762044739, 5126.384833819965, 5176.352955880515, 5223.738813059332, 5231.032259032015, 1015.4821041269006, 1035.13566172247, 1052.6631477927142, 1058.2909450668071, 1060.745421098946, 642.3415998601471, 657.2572992518519, 657.4247533408268, 659.4856012310405, 679.6975345971094, 11470.827937580943, 11983.16117871758, 12265.448054837554, 12721.0, 12805.743885122245, 665.4977671435921, 672.237010992527, 695.6730336741723, 712.5760172697237, 717.3400471566172, 5248.950209958024, 5291.601770130257, 5292.512399657403, 5304.443033481506, 5454.236406903036, 101871.4906425478, 102844.48577757063, 103931.4803425978, 106884.0, 107863.46068269608, 74599.0, 87383.0, 91059.08940910638, 93850.0, 96506.0, 71213.2878671217, 78320.0, 79607.60196199098, 80437.59781201174, 82262.17737822665, 12782.105252632227, 12992.805107923577, 13016.414261358452, 13106.0, 13249.867501324863, 36747.63252367442, 37403.25193496169, 37911.0, 37941.430878536295, 38244.61755382522, 43968.0, 47173.29240061333, 47250.0, 47717.52282477131, 47829.0, 17644.558886027953, 17700.46898593044, 18034.819651803315, 18180.0, 18232.81767182311, 19396.612067758848, 20195.293164739163, 20515.281965131147, 20563.383098507067, 20809.37571872846, 18735.437936861916, 19209.135588898254, 19459.221631134595, 19565.217391304188, 19580.510487237934, 17648.94106353623, 18103.366382176562, 18224.0, 18325.175367108244, 18484.075796210403, 17454.91272543629, 17506.387276445264, 17596.73604895953, 17674.64650706953, 17723.379681711078, 12943.482260709467, 13017.739645207232, 13627.386767595284, 13826.516071937434, 13836.100653457494, 13164.47342106305, 13936.163830170222, 14060.507882224074, 14345.282735862957, 14557.12657240569], "value": 8895.198379047031, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1527.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 111.0, 102.0, 109.0, 109.0, 112.0, 112.0, 101.0, 110.0, 109.0], "value": 107.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 117.0, 140.0, 168.0, 119.0, 149.0, 150.0, 118.0, 165.0, 126.0], "value": 140.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 164.0, 165.0, 161.0, 166.0, 167.0, 168.0, 166.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 182.0, 75.0, 74.0, 76.0, 89.0, 94.0, 84.0], "value": 89.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 135.0, 80.0, 81.0, 80.0, 126.0, 80.0, 81.0, 126.0], "value": 95.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 115.0, 114.0, 115.0, 114.0, 114.0, 114.0, 113.0, 115.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 151.0, 151.0, 152.0, 151.0, 152.0, 152.0, 151.0, 157.0], "value": 151.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 94.0, 93.0, 94.0, 95.0, 94.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 55.0, 62.0, 56.0, 56.0, 56.0, 54.0, 54.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 55.0, 53.0, 54.0, 54.0, 58.0, 55.0], "value": 54.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 78.0, 77.0, 88.0, 78.0, 79.0, 78.0, 88.0, 77.0, 84.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 126.0, 127.0, 127.0, 138.0, 127.0, 128.0, 135.0, 136.0, 161.0], "value": 133.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 187.0, 173.0, 176.0, 176.0, 179.0, 179.0, 177.0, 176.0, 173.0], "value": 177.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 69.0, 66.0, 70.0, 71.0, 68.0, 67.0, 67.0], "value": 68.2, "unit": "score"}]}]} 17:11:55 INFO - Return code: 0 17:11:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:11:55 INFO - # TBPL SUCCESS # 17:11:55 INFO - Running post-action listener: _package_coverage_data 17:11:55 INFO - Running post-action listener: _resource_record_post_action 17:11:55 INFO - [mozharness: 2017-07-25 00:11:55.700153Z] Finished run-tests step (success) 17:11:55 INFO - Running post-run listener: _resource_record_post_run 17:11:55 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 12288; Write bytes: 439009280; Read time: 180; Write time: 301988 17:11:55 INFO - TinderboxPrint: CPU usage
13.1% 17:11:55 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 180 17:11:55 INFO - TinderboxPrint: I/O write bytes / time
439,009,280 / 301,988 17:11:55 INFO - TinderboxPrint: CPU idle
8,262.6 (86.9%) 17:11:55 INFO - TinderboxPrint: CPU user
1,202.7 (12.6%) 17:11:55 INFO - TinderboxPrint: Swap in / out
0 / 0 17:11:55 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 108187648; Read time: 0; Write time: 69240 17:11:55 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:11:55 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 8192; Write bytes: 330821632; Read time: 172; Write time: 232748 17:11:56 INFO - Running post-run listener: _upload_blobber_files 17:11:56 INFO - Blob upload gear active. 17:11:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:11:56 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 17:11:56 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'] 17:11:56 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 17:11:56 INFO - (blobuploader) - INFO - Open directory for files ... 17:11:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:11:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:11:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:11:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:11:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:11:57 INFO - (blobuploader) - INFO - Done attempting. 17:11:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:11:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:11:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:12:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:12:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:12:04 INFO - (blobuploader) - INFO - Done attempting. 17:12:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:12:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:12:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:12:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:12:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:12:04 INFO - (blobuploader) - INFO - Done attempting. 17:12:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:12:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:12:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:12:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:12:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:12:05 INFO - (blobuploader) - INFO - Done attempting. 17:12:05 INFO - (blobuploader) - INFO - Iteration through files over. 17:12:05 INFO - Return code: 0 17:12:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:12:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:12:05 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c39eee4062c51fd6d1aa1beea4718fc00f19185b729e7af6862ae0cb4668400cc73e1267ad39ce15bf6165159b65922039c6e9498b7e7aed24c41bab97b79fe3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5bc688c1345b70b92dd0371cbb945c76e3690825172fe196e78547e26f593831fc0f5b18dba501c25d570ce8bb6724e54f7547ad503fad72bfadb9d1411b6020", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1106d3cff40c9a06b0fa20624a7f502817ea5ab1970eec131f1f9503e4926507998c2c4f891ddbaa1c4faa48cef8052facee6b58a5b1c8ce6770de00fc4e02a9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/36b282c8465c8b07bd0e185e8c86f233374a374bd37ac158d48aee1ed8bab6bfb36f3f04431c48a2011e64bee4f5a05bc2fbf20e082b7929df1a3484fc63c862"} 17:12:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:12:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:12:05 INFO - Contents: 17:12:05 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c39eee4062c51fd6d1aa1beea4718fc00f19185b729e7af6862ae0cb4668400cc73e1267ad39ce15bf6165159b65922039c6e9498b7e7aed24c41bab97b79fe3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5bc688c1345b70b92dd0371cbb945c76e3690825172fe196e78547e26f593831fc0f5b18dba501c25d570ce8bb6724e54f7547ad503fad72bfadb9d1411b6020", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1106d3cff40c9a06b0fa20624a7f502817ea5ab1970eec131f1f9503e4926507998c2c4f891ddbaa1c4faa48cef8052facee6b58a5b1c8ce6770de00fc4e02a9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/36b282c8465c8b07bd0e185e8c86f233374a374bd37ac158d48aee1ed8bab6bfb36f3f04431c48a2011e64bee4f5a05bc2fbf20e082b7929df1a3484fc63c862"} 17:12:05 INFO - Running post-run listener: copy_logs_to_upload_dir 17:12:05 INFO - Copying logs to upload dir... 17:12:05 INFO - mkdir: /builds/slave/test/build/upload/logs 17:12:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.101150 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-07-24 17:12:05.478979) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-24 17:12:05.487465) ========= 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-1500938396.991606-1626508640 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/c39eee4062c51fd6d1aa1beea4718fc00f19185b729e7af6862ae0cb4668400cc73e1267ad39ce15bf6165159b65922039c6e9498b7e7aed24c41bab97b79fe3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5bc688c1345b70b92dd0371cbb945c76e3690825172fe196e78547e26f593831fc0f5b18dba501c25d570ce8bb6724e54f7547ad503fad72bfadb9d1411b6020", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1106d3cff40c9a06b0fa20624a7f502817ea5ab1970eec131f1f9503e4926507998c2c4f891ddbaa1c4faa48cef8052facee6b58a5b1c8ce6770de00fc4e02a9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/36b282c8465c8b07bd0e185e8c86f233374a374bd37ac158d48aee1ed8bab6bfb36f3f04431c48a2011e64bee4f5a05bc2fbf20e082b7929df1a3484fc63c862"} build_url:https://queue.taskcluster.net/v1/task/KME2DeJkTQawjPY1Qqlefg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011333 build_url: 'https://queue.taskcluster.net/v1/task/KME2DeJkTQawjPY1Qqlefg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c39eee4062c51fd6d1aa1beea4718fc00f19185b729e7af6862ae0cb4668400cc73e1267ad39ce15bf6165159b65922039c6e9498b7e7aed24c41bab97b79fe3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5bc688c1345b70b92dd0371cbb945c76e3690825172fe196e78547e26f593831fc0f5b18dba501c25d570ce8bb6724e54f7547ad503fad72bfadb9d1411b6020", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1106d3cff40c9a06b0fa20624a7f502817ea5ab1970eec131f1f9503e4926507998c2c4f891ddbaa1c4faa48cef8052facee6b58a5b1c8ce6770de00fc4e02a9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/36b282c8465c8b07bd0e185e8c86f233374a374bd37ac158d48aee1ed8bab6bfb36f3f04431c48a2011e64bee4f5a05bc2fbf20e082b7929df1a3484fc63c862"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-24 17:12:05.511688) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 17:12:05.512008) ========= 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-1500938396.991606-1626508640 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004480 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 17:12:05.597144) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-24 17:12:05.597485) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-24 17:12:05.597869) ========= ========= Total master_lag: 0.28 =========