builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-062 starttime: 1503576861.41 results: success (0) revision: 8d1350135a04225958ada4c570e818366a3ae964 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-24 05:14:21.407093) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-24 05:14:21.407843) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-24 05:14:21.408369) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-24 05:14:21.420957) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 05:14:21.421336) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1503576859.425032-237178224 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-24 05:14:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2017-08-24 05:14:21 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127525 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 05:14:21.562182) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 05:14:21.562505) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1503576859.425032-237178224 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021518 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 05:14:21.613852) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 45 secs) (at 2017-08-24 05:14:21.614256) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8d1350135a04225958ada4c570e818366a3ae964 --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 8d1350135a04225958ada4c570e818366a3ae964 --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=a4ce256d2ec601f24a60a71e000001bc-1503576859.425032-237178224 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-24 05:14:21,801 truncating revision to first 12 chars 2017-08-24 05:14:21,801 Setting DEBUG logging. 2017-08-24 05:14:21,801 attempt 1/10 2017-08-24 05:14:21,801 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8d1350135a04?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-24 05:14:22,331 attempt 1/10 2017-08-24 05:14:22,870 current task status: no status available at this point. state: PENDING 2017-08-24 05:14:22,870 sleeping for 9.00s (attempt 1/10) 2017-08-24 05:14:31,879 attempt 2/10 2017-08-24 05:14:32,452 current task status: no status available at this point. state: PENDING 2017-08-24 05:14:32,452 sleeping for 13.50s (attempt 2/10) 2017-08-24 05:14:45,966 attempt 3/10 2017-08-24 05:14:46,483 current task status: no status available at this point. state: PENDING 2017-08-24 05:14:46,483 sleeping for 19.25s (attempt 3/10) 2017-08-24 05:15:05,752 attempt 4/10 2017-08-24 05:15:06,081 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-08-24 05:15:06,486 unpacking tar archive at: mozilla-central-8d1350135a04/testing/mozharness/ program finished with exit code 0 elapsedTime=44.997931 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 45 secs) (at 2017-08-24 05:15:06.626338) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-24 05:15:06.626636) ========= script_repo_revision: 8d1350135a04225958ada4c570e818366a3ae964 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-24 05:15:06.627000) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-24 05:15:06.627285) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-24 05:15:06.638284) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-08-24 05:15:06.638639) ========= /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=a4ce256d2ec601f24a60a71e000001bc-1503576859.425032-237178224 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:15:06 INFO - MultiFileLogger online at 20170824 05:15:06 in /builds/slave/test 05:15:06 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 05:15:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:15:06 INFO - {'append_to_log': False, 05:15:06 INFO - 'base_work_dir': '/builds/slave/test', 05:15:06 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 05:15:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:15:06 INFO - 'branch': 'Firefox-Non-PGO', 05:15:06 INFO - 'buildbot_json_path': 'buildprops.json', 05:15:06 INFO - 'code_coverage': False, 05:15:06 INFO - 'config_files': ('talos/linux_config.py',), 05:15:06 INFO - 'default_actions': ('clobber', 05:15:06 INFO - 'read-buildbot-config', 05:15:06 INFO - 'download-and-extract', 05:15:06 INFO - 'populate-webroot', 05:15:06 INFO - 'create-virtualenv', 05:15:06 INFO - 'install', 05:15:06 INFO - 'setup-mitmproxy', 05:15:06 INFO - 'run-tests'), 05:15:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:15:06 INFO - 'disable_ccov_upload': False, 05:15:06 INFO - 'download_minidump_stackwalk': True, 05:15:06 INFO - 'download_symbols': 'ondemand', 05:15:06 INFO - 'enable_stylo': False, 05:15:06 INFO - 'enable_webrender': False, 05:15:06 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 05:15:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:15:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:15:06 INFO - 'gecko_profile': False, 05:15:06 INFO - 'gecko_profile_interval': 0, 05:15:06 INFO - 'installer_path': 'installer.exe', 05:15:06 INFO - 'log_level': 'info', 05:15:06 INFO - 'log_name': 'talos', 05:15:06 INFO - 'log_to_console': True, 05:15:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:15:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:15:06 INFO - 'opt_config_files': (), 05:15:06 INFO - 'pip_index': False, 05:15:06 INFO - 'suite': 'dromaeojs-e10s', 05:15:06 INFO - 'system_bits': '32', 05:15:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:15:06 INFO - 'title': 'talos-linux64-ix-062', 05:15:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:15:06 INFO - 'use_talos_json': True, 05:15:06 INFO - 'verify': 'False', 05:15:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:15:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:15:06 INFO - 'work_dir': 'build'} 05:15:06 INFO - [mozharness: 2017-08-24 12:15:06.973819Z] Running clobber step. 05:15:06 INFO - Running pre-action listener: _resource_record_pre_action 05:15:06 INFO - Running main action method: clobber 05:15:06 INFO - rmtree: /builds/slave/test/build 05:15:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:15:08 INFO - Running post-action listener: _resource_record_post_action 05:15:08 INFO - [mozharness: 2017-08-24 12:15:08.518540Z] Finished clobber step (success) 05:15:08 INFO - [mozharness: 2017-08-24 12:15:08.518637Z] Running read-buildbot-config step. 05:15:08 INFO - Running pre-action listener: _resource_record_pre_action 05:15:08 INFO - Running main action method: read_buildbot_config 05:15:08 INFO - Using buildbot properties: 05:15:08 INFO - { 05:15:08 INFO - "project": "", 05:15:08 INFO - "product": "firefox", 05:15:08 INFO - "who": "archaeopteryx@coole-files.de", 05:15:08 INFO - "installer_path": "public/build/target.tar.bz2", 05:15:08 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:15:08 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 05:15:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 05:15:08 INFO - "stage_platform": "linux64", 05:15:08 INFO - "basedir": "/builds/slave/test", 05:15:08 INFO - "buildnumber": 1098, 05:15:08 INFO - "platform": "ubuntu64_hw", 05:15:08 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:15:08 INFO - "slavebuilddir": "test", 05:15:08 INFO - "taskId": "Q89W3lTeQxG48TWoW4hViQ", 05:15:08 INFO - "branch": "mozilla-central", 05:15:08 INFO - "script_repo_revision": "production", 05:15:08 INFO - "revision": "8d1350135a04225958ada4c570e818366a3ae964", 05:15:08 INFO - "slavename": "talos-linux64-ix-062", 05:15:08 INFO - "repo_path": "mozilla-central" 05:15:08 INFO - } 05:15:08 INFO - Finding installer, test and symbols from parent task. 05:15:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q89W3lTeQxG48TWoW4hViQ'}, attempt #1 05:15:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q89W3lTeQxG48TWoW4hViQ'}, attempt #1 05:15:09 INFO - Task dependencies: MFQIylfTTO67nd9VpmjjPg 05:15:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MFQIylfTTO67nd9VpmjjPg'}, attempt #1 05:15:10 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/MFQIylfTTO67nd9VpmjjPg/artifacts/public/build/target.tar.bz2 05:15:10 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/MFQIylfTTO67nd9VpmjjPg/artifacts/public/build/target.test_packages.json 05:15:10 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/MFQIylfTTO67nd9VpmjjPg/artifacts/public/build/target.crashreporter-symbols.zip 05:15:10 INFO - Running post-action listener: _resource_record_post_action 05:15:10 INFO - [mozharness: 2017-08-24 12:15:10.095255Z] Finished read-buildbot-config step (success) 05:15:10 INFO - [mozharness: 2017-08-24 12:15:10.095473Z] Running download-and-extract step. 05:15:10 INFO - Running pre-action listener: _resource_record_pre_action 05:15:10 INFO - Running main action method: download_and_extract 05:15:10 INFO - mkdir: /builds/slave/test/build/tests 05:15:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:10 INFO - trying https://queue.taskcluster.net/v1/task/MFQIylfTTO67nd9VpmjjPg/artifacts/public/build/target.test_packages.json 05:15:10 INFO - Downloading https://queue.taskcluster.net/v1/task/MFQIylfTTO67nd9VpmjjPg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:15:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MFQIylfTTO67nd9VpmjjPg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:15:10 INFO - Downloaded 989 bytes. 05:15:10 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:15:10 INFO - Using the following test package requirements: 05:15:10 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:15:10 INFO - u'common': [u'target.common.tests.zip'], 05:15:10 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:15:10 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:15:10 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:15:10 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:15:10 INFO - u'mozbase': [u'target.common.tests.zip'], 05:15:10 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:15:10 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:15:10 INFO - u'web-platform': [u'target.common.tests.zip', 05:15:10 INFO - u'target.web-platform.tests.tar.gz'], 05:15:10 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:15:10 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:15:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MFQIylfTTO67nd9VpmjjPg/artifacts/public/build/target.common.tests.zip 05:15:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MFQIylfTTO67nd9VpmjjPg/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:15:10 INFO - Fetch https://queue.taskcluster.net/v1/task/MFQIylfTTO67nd9VpmjjPg/artifacts/public/build/target.common.tests.zip into memory 05:15:11 INFO - Content-Length response header: 54979823 05:15:11 INFO - Bytes received: 54979823 05:15:22 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:15:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MFQIylfTTO67nd9VpmjjPg/artifacts/public/build/target.common.tests.zip 05:15:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MFQIylfTTO67nd9VpmjjPg/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:15:22 INFO - Fetch https://queue.taskcluster.net/v1/task/MFQIylfTTO67nd9VpmjjPg/artifacts/public/build/target.common.tests.zip into memory 05:15:23 INFO - Content-Length response header: 54979823 05:15:23 INFO - Bytes received: 54979823 05:15:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MFQIylfTTO67nd9VpmjjPg/artifacts/public/build/target.talos.tests.zip 05:15:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MFQIylfTTO67nd9VpmjjPg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:15:35 INFO - Fetch https://queue.taskcluster.net/v1/task/MFQIylfTTO67nd9VpmjjPg/artifacts/public/build/target.talos.tests.zip into memory 05:15:36 INFO - Content-Length response header: 14496384 05:15:36 INFO - Bytes received: 14496384 05:15:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:36 INFO - trying https://queue.taskcluster.net/v1/task/MFQIylfTTO67nd9VpmjjPg/artifacts/public/build/target.tar.bz2 05:15:36 INFO - Downloading https://queue.taskcluster.net/v1/task/MFQIylfTTO67nd9VpmjjPg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:15:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MFQIylfTTO67nd9VpmjjPg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:15:38 INFO - Downloaded 61016854 bytes. 05:15:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MFQIylfTTO67nd9VpmjjPg/artifacts/public/build/target.tar.bz2 05:15:38 INFO - mkdir: /builds/slave/test/properties 05:15:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:15:38 INFO - Writing to file /builds/slave/test/properties/build_url 05:15:38 INFO - Contents: 05:15:38 INFO - build_url:https://queue.taskcluster.net/v1/task/MFQIylfTTO67nd9VpmjjPg/artifacts/public/build/target.tar.bz2 05:15:38 INFO - Running post-action listener: _resource_record_post_action 05:15:38 INFO - Running post-action listener: find_tests_for_verification 05:15:38 INFO - Running post-action listener: set_extra_try_arguments 05:15:38 INFO - [mozharness: 2017-08-24 12:15:38.071534Z] Finished download-and-extract step (success) 05:15:38 INFO - [mozharness: 2017-08-24 12:15:38.071631Z] Running populate-webroot step. 05:15:38 INFO - Running pre-action listener: _resource_record_pre_action 05:15:38 INFO - Running main action method: populate_webroot 05:15:38 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:15:38 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 05:15:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:15:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:15:38 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 05:15:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:15:38 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:15:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:15:38 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 05:15:38 INFO - 'talos_options': ['--stylo'], 05:15:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:15:38 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:15:38 INFO - 'tests': ['damp', 'tps']}, 05:15:38 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 05:15:38 INFO - 'talos_options': ['--stylo'], 05:15:38 INFO - 'tests': ['damp', 'tps']}, 05:15:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:15:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:15:38 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 05:15:38 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:15:38 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:15:38 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:15:38 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 05:15:38 INFO - 'talos_options': ['--stylo'], 05:15:38 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:15:38 INFO - 'other-e10s': {'tests': ['a11yr', 05:15:38 INFO - 'ts_paint', 05:15:38 INFO - 'tpaint', 05:15:38 INFO - 'sessionrestore', 05:15:38 INFO - 'sessionrestore_many_windows', 05:15:38 INFO - 'sessionrestore_no_auto_restore', 05:15:38 INFO - 'tabpaint']}, 05:15:38 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 05:15:38 INFO - 'tests': ['a11yr', 05:15:38 INFO - 'ts_paint', 05:15:38 INFO - 'tpaint', 05:15:38 INFO - 'sessionrestore', 05:15:38 INFO - 'sessionrestore_many_windows', 05:15:38 INFO - 'sessionrestore_no_auto_restore', 05:15:38 INFO - 'tabpaint']}, 05:15:38 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 05:15:38 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 05:15:38 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 05:15:38 INFO - 'tests': ['bloom_basic_singleton']}, 05:15:38 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 05:15:38 INFO - 'tests': ['bloom_basic']}, 05:15:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:15:38 INFO - 'tsvgr_opacity', 05:15:38 INFO - 'tart', 05:15:38 INFO - 'tscrollx', 05:15:38 INFO - 'tsvg_static']}, 05:15:38 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 05:15:38 INFO - 'tests': ['tsvgx', 05:15:38 INFO - 'tsvgr_opacity', 05:15:38 INFO - 'tart', 05:15:38 INFO - 'tscrollx', 05:15:38 INFO - 'tsvg_static']}, 05:15:38 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:15:38 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 05:15:38 INFO - 'talos_options': ['--stylo'], 05:15:38 INFO - 'tests': ['tp5o']}, 05:15:38 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:15:38 INFO - 'talos_options': ['--mitmproxy', 05:15:38 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:15:38 INFO - '--firstNonBlankPaint'], 05:15:38 INFO - 'tests': ['tp6_google', 05:15:38 INFO - 'tp6_youtube', 05:15:38 INFO - 'tp6_amazon', 05:15:38 INFO - 'tp6_facebook']}, 05:15:38 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:15:38 INFO - 'talos_options': ['--stylo', 05:15:38 INFO - '--mitmproxy', 05:15:38 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:15:38 INFO - '--firstNonBlankPaint'], 05:15:38 INFO - 'tests': ['tp6_google', 05:15:38 INFO - 'tp6_youtube', 05:15:38 INFO - 'tp6_amazon', 05:15:38 INFO - 'tp6_facebook']}, 05:15:38 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:15:38 INFO - 'talos_options': ['--stylo', 05:15:38 INFO - '--stylo-threads=1', 05:15:38 INFO - '--mitmproxy', 05:15:38 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:15:38 INFO - '--firstNonBlankPaint'], 05:15:38 INFO - 'tests': ['tp6_google', 05:15:38 INFO - 'tp6_youtube', 05:15:38 INFO - 'tp6_amazon', 05:15:38 INFO - 'tp6_facebook']}, 05:15:38 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:15:38 INFO - 'talos_options': ['--xperf_path', 05:15:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:15:38 INFO - 'tests': ['tp5n']}, 05:15:38 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 05:15:38 INFO - 'talos_options': ['--stylo', 05:15:38 INFO - '--xperf_path', 05:15:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:15:38 INFO - 'tests': ['tp5n']}}} 05:15:38 INFO - Running post-action listener: _resource_record_post_action 05:15:38 INFO - [mozharness: 2017-08-24 12:15:38.085802Z] Finished populate-webroot step (success) 05:15:38 INFO - [mozharness: 2017-08-24 12:15:38.085892Z] Running create-virtualenv step. 05:15:38 INFO - Running pre-action listener: _resource_record_pre_action 05:15:38 INFO - Running main action method: create_virtualenv 05:15:38 INFO - Creating virtualenv /builds/slave/test/build/venv 05:15:38 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:15:38 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 05:15:38 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:15:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:15:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:15:38 INFO - Installing distribute.............................................................................................................................................................................................done. 05:15:39 INFO - Installing pip...............done. 05:15:39 INFO - Return code: 0 05:15:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:15:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:15:39 INFO - Reading from file tmpfile_stdout 05:15:39 INFO - Output received: 05:15:39 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 05:15:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1351a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f4f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f2130>, '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 0x14f3030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f34c0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1503576859.425032-237178224', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:15:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:15:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:15:39 INFO - Using env: {'DISPLAY': ':0', 05:15:39 INFO - 'HOME': '/home/cltbld', 05:15:39 INFO - 'LANG': 'en_US.UTF-8', 05:15:39 INFO - 'LANGUAGE': 'en_US:en', 05:15:39 INFO - 'LOGNAME': 'cltbld', 05:15:39 INFO - 'MAIL': '/var/mail/cltbld', 05:15:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:39 INFO - 'MOZ_NO_REMOTE': '1', 05:15:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:39 INFO - 'NO_EM_RESTART': '1', 05:15:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:39 INFO - 'PWD': '/builds/slave/test', 05:15:39 INFO - 'SHELL': '/bin/bash', 05:15:39 INFO - 'SHLVL': '1', 05:15:39 INFO - 'TERM': 'linux', 05:15:39 INFO - 'TMOUT': '86400', 05:15:39 INFO - 'USER': 'cltbld', 05:15:39 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1503576859.425032-237178224', 05:15:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:39 INFO - '_': '/tools/buildbot/bin/python'} 05:15:40 INFO - Ignoring indexes: http://pypi.python.org/simple/ 05:15:40 INFO - Downloading/unpacking pip>=1.5 05:15:40 INFO - Running setup.py egg_info for package pip 05:15:40 INFO - warning: no files found matching 'pip/cacert.pem' 05:15:40 INFO - warning: no files found matching '*.html' under directory 'docs' 05:15:40 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 05:15:40 INFO - no previously-included directories found matching 'docs/_build/_sources' 05:15:40 INFO - Installing collected packages: pip 05:15:40 INFO - Found existing installation: pip 1.1 05:15:40 INFO - Uninstalling pip: 05:15:40 INFO - Successfully uninstalled pip 05:15:40 INFO - Running setup.py install for pip 05:15:40 INFO - warning: no files found matching 'pip/cacert.pem' 05:15:40 INFO - warning: no files found matching '*.html' under directory 'docs' 05:15:40 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 05:15:40 INFO - no previously-included directories found matching 'docs/_build/_sources' 05:15:40 INFO - Installing pip script to /builds/slave/test/build/venv/bin 05:15:40 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 05:15:40 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 05:15:40 INFO - Successfully installed pip 05:15:40 INFO - Cleaning up... 05:15:40 INFO - Return code: 0 05:15:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:40 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 0x11861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1351a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f4f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f2130>, '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 0x14f3030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f34c0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1503576859.425032-237178224', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:15:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:15:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:15:40 INFO - Using env: {'DISPLAY': ':0', 05:15:40 INFO - 'HOME': '/home/cltbld', 05:15:40 INFO - 'LANG': 'en_US.UTF-8', 05:15:40 INFO - 'LANGUAGE': 'en_US:en', 05:15:40 INFO - 'LOGNAME': 'cltbld', 05:15:40 INFO - 'MAIL': '/var/mail/cltbld', 05:15:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:40 INFO - 'MOZ_NO_REMOTE': '1', 05:15:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:40 INFO - 'NO_EM_RESTART': '1', 05:15:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:40 INFO - 'PWD': '/builds/slave/test', 05:15:40 INFO - 'SHELL': '/bin/bash', 05:15:40 INFO - 'SHLVL': '1', 05:15:40 INFO - 'TERM': 'linux', 05:15:40 INFO - 'TMOUT': '86400', 05:15:40 INFO - 'USER': 'cltbld', 05:15:40 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1503576859.425032-237178224', 05:15:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:40 INFO - '_': '/tools/buildbot/bin/python'} 05:15:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:40 INFO - Downloading/unpacking psutil>=3.1.1 05:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:15:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:15:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:15:41 INFO - Installing collected packages: psutil 05:15:41 INFO - Running setup.py install for psutil 05:15:41 INFO - building 'psutil._psutil_linux' extension 05:15:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:15:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:15:42 INFO - building 'psutil._psutil_posix' extension 05:15:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:15:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:15:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:15:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:15:42 INFO - Successfully installed psutil 05:15:42 INFO - Cleaning up... 05:15:42 INFO - Return code: 0 05:15:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x11861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1351a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f4f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f2130>, '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 0x14f3030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f34c0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1503576859.425032-237178224', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:15:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:15:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:15:42 INFO - Using env: {'DISPLAY': ':0', 05:15:42 INFO - 'HOME': '/home/cltbld', 05:15:42 INFO - 'LANG': 'en_US.UTF-8', 05:15:42 INFO - 'LANGUAGE': 'en_US:en', 05:15:42 INFO - 'LOGNAME': 'cltbld', 05:15:42 INFO - 'MAIL': '/var/mail/cltbld', 05:15:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:42 INFO - 'MOZ_NO_REMOTE': '1', 05:15:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:42 INFO - 'NO_EM_RESTART': '1', 05:15:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:42 INFO - 'PWD': '/builds/slave/test', 05:15:42 INFO - 'SHELL': '/bin/bash', 05:15:42 INFO - 'SHLVL': '1', 05:15:42 INFO - 'TERM': 'linux', 05:15:42 INFO - 'TMOUT': '86400', 05:15:42 INFO - 'USER': 'cltbld', 05:15:42 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1503576859.425032-237178224', 05:15:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:42 INFO - '_': '/tools/buildbot/bin/python'} 05:15:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:15:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:15:43 INFO - Installing collected packages: mozsystemmonitor 05:15:43 INFO - Running setup.py install for mozsystemmonitor 05:15:43 INFO - Successfully installed mozsystemmonitor 05:15:43 INFO - Cleaning up... 05:15:43 INFO - Return code: 0 05:15:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:15:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:43 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 0x11861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1351a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f4f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f2130>, '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 0x14f3030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f34c0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1503576859.425032-237178224', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:15:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:15:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:15:43 INFO - Using env: {'DISPLAY': ':0', 05:15:43 INFO - 'HOME': '/home/cltbld', 05:15:43 INFO - 'LANG': 'en_US.UTF-8', 05:15:43 INFO - 'LANGUAGE': 'en_US:en', 05:15:43 INFO - 'LOGNAME': 'cltbld', 05:15:43 INFO - 'MAIL': '/var/mail/cltbld', 05:15:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:43 INFO - 'MOZ_NO_REMOTE': '1', 05:15:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:43 INFO - 'NO_EM_RESTART': '1', 05:15:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:43 INFO - 'PWD': '/builds/slave/test', 05:15:43 INFO - 'SHELL': '/bin/bash', 05:15:43 INFO - 'SHLVL': '1', 05:15:43 INFO - 'TERM': 'linux', 05:15:43 INFO - 'TMOUT': '86400', 05:15:43 INFO - 'USER': 'cltbld', 05:15:43 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1503576859.425032-237178224', 05:15:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:43 INFO - '_': '/tools/buildbot/bin/python'} 05:15:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:44 INFO - Downloading/unpacking jsonschema==2.5.1 05:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:15:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:15: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 05:15: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 05:15: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 05:15: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 05:15:45 INFO - Downloading functools32-3.2.3-2.tar.gz 05:15:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:15:45 INFO - warning: no files found matching '*.txt' 05:15:45 INFO - no previously-included directories found matching 'build' 05:15:45 INFO - no previously-included directories found matching 'dist' 05:15:45 INFO - no previously-included directories found matching '.git*' 05:15:45 INFO - Installing collected packages: jsonschema, functools32 05:15:45 INFO - Running setup.py install for functools32 05:15:45 INFO - warning: no files found matching '*.txt' 05:15:45 INFO - no previously-included directories found matching 'build' 05:15:45 INFO - no previously-included directories found matching 'dist' 05:15:45 INFO - no previously-included directories found matching '.git*' 05:15:45 INFO - Successfully installed jsonschema functools32 05:15:45 INFO - Cleaning up... 05:15:45 INFO - Return code: 0 05:15:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:15:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--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 0x11861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1351a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f4f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f2130>, '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 0x14f3030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f34c0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1503576859.425032-237178224', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:15:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:15: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 functools32==3.2.3-2 05:15:45 INFO - Using env: {'DISPLAY': ':0', 05:15:45 INFO - 'HOME': '/home/cltbld', 05:15:45 INFO - 'LANG': 'en_US.UTF-8', 05:15:45 INFO - 'LANGUAGE': 'en_US:en', 05:15:45 INFO - 'LOGNAME': 'cltbld', 05:15:45 INFO - 'MAIL': '/var/mail/cltbld', 05:15:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:45 INFO - 'MOZ_NO_REMOTE': '1', 05:15:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:45 INFO - 'NO_EM_RESTART': '1', 05:15:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:45 INFO - 'PWD': '/builds/slave/test', 05:15:45 INFO - 'SHELL': '/bin/bash', 05:15:45 INFO - 'SHLVL': '1', 05:15:45 INFO - 'TERM': 'linux', 05:15:45 INFO - 'TMOUT': '86400', 05:15:45 INFO - 'USER': 'cltbld', 05:15:45 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1503576859.425032-237178224', 05:15:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:45 INFO - '_': '/tools/buildbot/bin/python'} 05:15:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:15:45 INFO - Cleaning up... 05:15:45 INFO - Return code: 0 05:15:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:15:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--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 0x11861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1351a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f4f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f2130>, '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 0x14f3030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f34c0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1503576859.425032-237178224', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:15:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:15: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 blobuploader==1.2.4 05:15:45 INFO - Using env: {'DISPLAY': ':0', 05:15:45 INFO - 'HOME': '/home/cltbld', 05:15:45 INFO - 'LANG': 'en_US.UTF-8', 05:15:45 INFO - 'LANGUAGE': 'en_US:en', 05:15:45 INFO - 'LOGNAME': 'cltbld', 05:15:45 INFO - 'MAIL': '/var/mail/cltbld', 05:15:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:45 INFO - 'MOZ_NO_REMOTE': '1', 05:15:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:45 INFO - 'NO_EM_RESTART': '1', 05:15:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:45 INFO - 'PWD': '/builds/slave/test', 05:15:45 INFO - 'SHELL': '/bin/bash', 05:15:45 INFO - 'SHLVL': '1', 05:15:45 INFO - 'TERM': 'linux', 05:15:45 INFO - 'TMOUT': '86400', 05:15:45 INFO - 'USER': 'cltbld', 05:15:45 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1503576859.425032-237178224', 05:15:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:45 INFO - '_': '/tools/buildbot/bin/python'} 05:15:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:46 INFO - Downloading/unpacking blobuploader==1.2.4 05:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:47 INFO - Downloading blobuploader-1.2.4.tar.gz 05:15:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:15:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:15:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:47 INFO - Downloading docopt-0.6.1.tar.gz 05:15:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:15:47 INFO - Installing collected packages: blobuploader, requests, docopt 05:15:47 INFO - Running setup.py install for blobuploader 05:15:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:15:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:15:47 INFO - Running setup.py install for requests 05:15:48 INFO - Running setup.py install for docopt 05:15:48 INFO - Successfully installed blobuploader requests docopt 05:15:48 INFO - Cleaning up... 05:15:48 INFO - Return code: 0 05:15:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x11861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1351a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f4f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f2130>, '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 0x14f3030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f34c0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1503576859.425032-237178224', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:15:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:15:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:15:48 INFO - Using env: {'DISPLAY': ':0', 05:15:48 INFO - 'HOME': '/home/cltbld', 05:15:48 INFO - 'LANG': 'en_US.UTF-8', 05:15:48 INFO - 'LANGUAGE': 'en_US:en', 05:15:48 INFO - 'LOGNAME': 'cltbld', 05:15:48 INFO - 'MAIL': '/var/mail/cltbld', 05:15:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:48 INFO - 'MOZ_NO_REMOTE': '1', 05:15:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:48 INFO - 'NO_EM_RESTART': '1', 05:15:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:48 INFO - 'PWD': '/builds/slave/test', 05:15:48 INFO - 'SHELL': '/bin/bash', 05:15:48 INFO - 'SHLVL': '1', 05:15:48 INFO - 'TERM': 'linux', 05:15:48 INFO - 'TMOUT': '86400', 05:15:48 INFO - 'USER': 'cltbld', 05:15:48 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1503576859.425032-237178224', 05:15:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:48 INFO - '_': '/tools/buildbot/bin/python'} 05:15:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:15:48 INFO - Running setup.py (path:/tmp/pip-EwJs5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:15:48 INFO - Running setup.py (path:/tmp/pip-EXDZ1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:15:48 INFO - Running setup.py (path:/tmp/pip-vmsqbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:15:48 INFO - Running setup.py (path:/tmp/pip-7pA9BN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:15:48 INFO - Running setup.py (path:/tmp/pip-548ThY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:15:48 INFO - Running setup.py (path:/tmp/pip-EMK0Vb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:15:48 INFO - Running setup.py (path:/tmp/pip-PCvJOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:15:49 INFO - Running setup.py (path:/tmp/pip-VsY9JN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:15:49 INFO - Running setup.py (path:/tmp/pip-RnYbxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:15:49 INFO - Running setup.py (path:/tmp/pip-iZo2z4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:15:49 INFO - Running setup.py (path:/tmp/pip-99z5rB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:15:49 INFO - Running setup.py (path:/tmp/pip-1ymZVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:15:49 INFO - Running setup.py (path:/tmp/pip-9W17x8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:15:49 INFO - Running setup.py (path:/tmp/pip-2OPku7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:49 INFO - Running setup.py (path:/tmp/pip-SyZLav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:15:49 INFO - Running setup.py (path:/tmp/pip-w5El7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:15:49 INFO - Running setup.py (path:/tmp/pip-3nMwNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:15:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:15:49 INFO - Running setup.py install for manifestparser 05:15:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:15:49 INFO - Running setup.py install for mozcrash 05:15:49 INFO - Running setup.py install for mozdebug 05:15:50 INFO - Running setup.py install for mozdevice 05:15:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:15:50 INFO - Running setup.py install for mozfile 05:15:50 INFO - Running setup.py install for mozhttpd 05:15:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:15:50 INFO - Running setup.py install for mozinfo 05:15:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:15:50 INFO - Running setup.py install for mozInstall 05:15:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:15:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:15:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:15:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:15:50 INFO - Running setup.py install for mozleak 05:15:50 INFO - Running setup.py install for mozlog 05:15:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:15:50 INFO - Running setup.py install for moznetwork 05:15:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:15:50 INFO - Running setup.py install for mozprocess 05:15:50 INFO - Running setup.py install for mozprofile 05:15:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:15:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:15:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:15:51 INFO - Running setup.py install for mozrunner 05:15:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:15:51 INFO - Running setup.py install for mozscreenshot 05:15:51 INFO - Running setup.py install for moztest 05:15:51 INFO - Running setup.py install for mozversion 05:15:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:15:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:15:51 INFO - Cleaning up... 05:15:51 INFO - Return code: 0 05:15:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:15:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-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 0x11861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1351a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f4f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f2130>, '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 0x14f3030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f34c0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1503576859.425032-237178224', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:15:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:15:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:15:51 INFO - Using env: {'DISPLAY': ':0', 05:15:51 INFO - 'HOME': '/home/cltbld', 05:15:51 INFO - 'LANG': 'en_US.UTF-8', 05:15:51 INFO - 'LANGUAGE': 'en_US:en', 05:15:51 INFO - 'LOGNAME': 'cltbld', 05:15:51 INFO - 'MAIL': '/var/mail/cltbld', 05:15:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:51 INFO - 'MOZ_NO_REMOTE': '1', 05:15:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:51 INFO - 'NO_EM_RESTART': '1', 05:15:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:51 INFO - 'PWD': '/builds/slave/test', 05:15:51 INFO - 'SHELL': '/bin/bash', 05:15:51 INFO - 'SHLVL': '1', 05:15:51 INFO - 'TERM': 'linux', 05:15:51 INFO - 'TMOUT': '86400', 05:15:51 INFO - 'USER': 'cltbld', 05:15:51 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1503576859.425032-237178224', 05:15:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:51 INFO - '_': '/tools/buildbot/bin/python'} 05:15:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:15:51 INFO - Running setup.py (path:/tmp/pip-LpEW03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:15:51 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:15:51 INFO - Running setup.py (path:/tmp/pip-bF903I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:15:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:15:51 INFO - Running setup.py (path:/tmp/pip-_SX3De-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:15:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:15:51 INFO - Running setup.py (path:/tmp/pip-mQt3KW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:15:52 INFO - Running setup.py (path:/tmp/pip-USPls_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:15:52 INFO - Running setup.py (path:/tmp/pip-qJavko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:15:52 INFO - Running setup.py (path:/tmp/pip-uqLhm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:15:52 INFO - Running setup.py (path:/tmp/pip-V2n9Mp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:15:52 INFO - Running setup.py (path:/tmp/pip-IXDSjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:15:52 INFO - Running setup.py (path:/tmp/pip-hFo1kR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:15:52 INFO - Running setup.py (path:/tmp/pip-a8YEhP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:15:52 INFO - Running setup.py (path:/tmp/pip-22bvZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:15:52 INFO - Running setup.py (path:/tmp/pip-WIa4mP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:15:52 INFO - Running setup.py (path:/tmp/pip-5VBuwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:52 INFO - Running setup.py (path:/tmp/pip-GP84A6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:15:52 INFO - Running setup.py (path:/tmp/pip-Pyb7EN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:15:52 INFO - Running setup.py (path:/tmp/pip-FyoPjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:15:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:15: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 05:15: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 05:15: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 05:15: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 05:15:54 INFO - Downloading blessings-1.6.tar.gz 05:15:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:15:54 INFO - Installing collected packages: blessings 05:15:54 INFO - Running setup.py install for blessings 05:15:54 INFO - Successfully installed blessings 05:15:54 INFO - Cleaning up... 05:15:54 INFO - Return code: 0 05:15:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:15:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:15:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:15:54 INFO - Reading from file tmpfile_stdout 05:15:54 INFO - Current package versions: 05:15:54 INFO - argparse == 1.2.1 05:15:54 INFO - blessings == 1.6 05:15:54 INFO - blobuploader == 1.2.4 05:15:54 INFO - docopt == 0.6.1 05:15:54 INFO - functools32 == 3.2.3-2 05:15:54 INFO - jsonschema == 2.5.1 05:15:54 INFO - manifestparser == 1.1 05:15:54 INFO - mozInstall == 1.13 05:15:54 INFO - mozcrash == 1.0 05:15:54 INFO - mozdebug == 0.1 05:15:54 INFO - mozdevice == 0.51 05:15:54 INFO - mozfile == 1.2 05:15:54 INFO - mozhttpd == 0.7 05:15:54 INFO - mozinfo == 0.10 05:15:54 INFO - mozleak == 0.1 05:15:54 INFO - mozlog == 3.5 05:15:54 INFO - moznetwork == 0.27 05:15:54 INFO - mozprocess == 0.25 05:15:54 INFO - mozprofile == 0.28 05:15:54 INFO - mozrunner == 6.13 05:15:54 INFO - mozscreenshot == 0.1 05:15:54 INFO - mozsystemmonitor == 0.3 05:15:54 INFO - moztest == 0.8 05:15:54 INFO - mozversion == 1.4 05:15:54 INFO - psutil == 3.1.1 05:15:54 INFO - requests == 1.2.3 05:15:54 INFO - wsgiref == 0.1.2 05:15:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:54 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 0x11861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1351a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f4f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f2130>, '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 0x14f3030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f34c0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1503576859.425032-237178224', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:15:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:15:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:15:54 INFO - Using env: {'DISPLAY': ':0', 05:15:54 INFO - 'HOME': '/home/cltbld', 05:15:54 INFO - 'LANG': 'en_US.UTF-8', 05:15:54 INFO - 'LANGUAGE': 'en_US:en', 05:15:54 INFO - 'LOGNAME': 'cltbld', 05:15:54 INFO - 'MAIL': '/var/mail/cltbld', 05:15:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:54 INFO - 'MOZ_NO_REMOTE': '1', 05:15:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:54 INFO - 'NO_EM_RESTART': '1', 05:15:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:54 INFO - 'PWD': '/builds/slave/test', 05:15:54 INFO - 'SHELL': '/bin/bash', 05:15:54 INFO - 'SHLVL': '1', 05:15:54 INFO - 'TERM': 'linux', 05:15:54 INFO - 'TMOUT': '86400', 05:15:54 INFO - 'USER': 'cltbld', 05:15:54 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1503576859.425032-237178224', 05:15:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:54 INFO - '_': '/tools/buildbot/bin/python'} 05:15:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:15:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:15:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:15:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:15:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:15:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:15:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:15:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:15:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:15:54 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 05:15:55 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:15:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:15:55 INFO - Installing collected packages: simplejson 05:15:55 INFO - Running setup.py install for simplejson 05:15:55 INFO - building 'simplejson._speedups' extension 05:15:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 05:15:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 05:15:56 INFO - Successfully installed simplejson 05:15:56 INFO - Cleaning up... 05:15:56 INFO - Return code: 0 05:15:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:15: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')]} 05:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15: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')]} 05:15:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:56 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 0x11861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1351a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f4f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f2130>, '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 0x14f3030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f34c0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1503576859.425032-237178224', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:15:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:15:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:15:56 INFO - Using env: {'DISPLAY': ':0', 05:15:56 INFO - 'HOME': '/home/cltbld', 05:15:56 INFO - 'LANG': 'en_US.UTF-8', 05:15:56 INFO - 'LANGUAGE': 'en_US:en', 05:15:56 INFO - 'LOGNAME': 'cltbld', 05:15:56 INFO - 'MAIL': '/var/mail/cltbld', 05:15:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:56 INFO - 'MOZ_NO_REMOTE': '1', 05:15:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:56 INFO - 'NO_EM_RESTART': '1', 05:15:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:56 INFO - 'PWD': '/builds/slave/test', 05:15:56 INFO - 'SHELL': '/bin/bash', 05:15:56 INFO - 'SHLVL': '1', 05:15:56 INFO - 'TERM': 'linux', 05:15:56 INFO - 'TMOUT': '86400', 05:15:56 INFO - 'USER': 'cltbld', 05:15:56 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1503576859.425032-237178224', 05:15:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:56 INFO - '_': '/tools/buildbot/bin/python'} 05:15:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:15:57 INFO - Cleaning up... 05:15:57 INFO - Return code: 0 05:15:57 INFO - Running post-action listener: _resource_record_post_action 05:15:57 INFO - Running post-action listener: _start_resource_monitoring 05:15:57 INFO - Starting resource monitoring. 05:15:57 INFO - [mozharness: 2017-08-24 12:15:57.199663Z] Finished create-virtualenv step (success) 05:15:57 INFO - [mozharness: 2017-08-24 12:15:57.200176Z] Running install step. 05:15:57 INFO - Running pre-action listener: _resource_record_pre_action 05:15:57 INFO - Running main action method: install 05:15:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:15:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:15:57 INFO - Reading from file tmpfile_stdout 05:15:57 INFO - Detecting whether we're running mozinstall >=1.0... 05:15:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:15:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:15:57 INFO - Reading from file tmpfile_stdout 05:15:57 INFO - Output received: 05:15:57 INFO - Usage: mozinstall [options] installer 05:15:57 INFO - Options: 05:15:57 INFO - -h, --help show this help message and exit 05:15:57 INFO - -d DEST, --destination=DEST 05:15:57 INFO - Directory to install application into. [default: 05:15:57 INFO - "/builds/slave/test"] 05:15:57 INFO - --app=APP Application being installed. [default: firefox] 05:15:57 INFO - mkdir: /builds/slave/test/build/application 05:15:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:15:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:16:15 INFO - Reading from file tmpfile_stdout 05:16:15 INFO - Output received: 05:16:15 INFO - /builds/slave/test/build/application/firefox/firefox 05:16:15 INFO - Running post-action listener: _resource_record_post_action 05:16:15 INFO - [mozharness: 2017-08-24 12:16:15.227718Z] Finished install step (success) 05:16:15 INFO - [mozharness: 2017-08-24 12:16:15.227999Z] Running setup-mitmproxy step. 05:16:15 INFO - Running pre-action listener: _resource_record_pre_action 05:16:15 INFO - Running main action method: setup_mitmproxy 05:16:15 INFO - Skipping: mitmproxy is not required 05:16:15 INFO - Running post-action listener: _resource_record_post_action 05:16:15 INFO - [mozharness: 2017-08-24 12:16:15.229130Z] Finished setup-mitmproxy step (success) 05:16:15 INFO - [mozharness: 2017-08-24 12:16:15.229493Z] Running run-tests step. 05:16:15 INFO - Running pre-action listener: _resource_record_pre_action 05:16:15 INFO - Running pre-action listener: _set_gcov_prefix 05:16:15 INFO - Running main action method: run_tests 05:16:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:16:15 INFO - Python 2.7.3 05:16:15 INFO - Return code: 0 05:16:15 INFO - grabbing minidump binary from tooltool 05:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:15 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 0x14f2130>, '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 0x14f3030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f34c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:16:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:16:15 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:16:15 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:16:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:16:15 INFO - Return code: 0 05:16:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:16:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:16:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:16:15 INFO - ENV: RUST_BACKTRACE is now full 05:16:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:16:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:16:15 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/MFQIylfTTO67nd9VpmjjPg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:16:15 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/MFQIylfTTO67nd9VpmjjPg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-062 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:16:15 INFO - Using env: {'DISPLAY': ':0', 05:16:15 INFO - 'HOME': '/home/cltbld', 05:16:15 INFO - 'LANG': 'en_US.UTF-8', 05:16:15 INFO - 'LANGUAGE': 'en_US:en', 05:16:15 INFO - 'LOGNAME': 'cltbld', 05:16:15 INFO - 'MAIL': '/var/mail/cltbld', 05:16:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:16:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:16:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:15 INFO - 'MOZ_NO_REMOTE': '1', 05:16:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:16:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:15 INFO - 'NO_EM_RESTART': '1', 05:16:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:15 INFO - 'PWD': '/builds/slave/test', 05:16:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:16:15 INFO - 'RUST_BACKTRACE': 'full', 05:16:15 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:16:15 INFO - 'SHELL': '/bin/bash', 05:16:15 INFO - 'SHLVL': '1', 05:16:15 INFO - 'TERM': 'linux', 05:16:15 INFO - 'TMOUT': '86400', 05:16:15 INFO - 'USER': 'cltbld', 05:16:15 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1503576859.425032-237178224', 05:16:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:15 INFO - '_': '/tools/buildbot/bin/python'} 05:16:15 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/MFQIylfTTO67nd9VpmjjPg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:16:15 INFO - mozversion application_buildid: 20170824112712 05:16:15 INFO - mozversion application_changeset: 8d1350135a04225958ada4c570e818366a3ae964 05:16:15 INFO - mozversion application_display_name: Nightly 05:16:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:16:15 INFO - mozversion application_name: Firefox 05:16:15 INFO - mozversion application_remotingname: firefox 05:16:15 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:16:15 INFO - mozversion application_vendor: Mozilla 05:16:15 INFO - mozversion application_version: 57.0a1 05:16:15 INFO - mozversion platform_buildid: 20170824112712 05:16:15 INFO - mozversion platform_changeset: 8d1350135a04225958ada4c570e818366a3ae964 05:16:15 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:16:15 INFO - mozversion platform_version: 57.0a1 05:16:15 INFO - using testdate: 1503576975 05:16:15 INFO - actual date: 1503576975 05:16:15 INFO - starting webserver on 'localhost:42795' 05:16:15 INFO - SUITE-START | Running 2 tests 05:16:15 INFO - TEST-START | dromaeo_css 05:16:15 INFO - Initialising browser for dromaeo_css test... 05:16:15 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42795/getInfo.html -profile /tmp/tmpGrIVHi/profile 05:16:15 INFO - TEST-INFO | started process 22032 (/builds/slave/test/build/application/firefox/firefox http://localhost:42795/getInfo.html) 05:16:21 INFO - TEST-INFO | 22032: exit 0 05:16:21 INFO - Browser initialized. 05:16:21 INFO - Running cycle 1/1 for dromaeo_css test... 05:16:21 INFO - TEST-INFO | started process 22206 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGrIVHi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:16:22 INFO - PID 22206 | 05:16:22 INFO - PID 22206 | (/builds/slave/test/build/application/firefox/firefox:22256): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:16:22 INFO - PID 22206 | 05:16:22 INFO - PID 22206 | 05:16:22 INFO - PID 22206 | (/builds/slave/test/build/application/firefox/firefox:22311): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:16:22 INFO - PID 22206 | 05:16:22 INFO - PID 22206 | __metrics Screen width/height:1600/1200 05:16:22 INFO - PID 22206 | colorDepth:24 05:16:22 INFO - PID 22206 | Browser inner width/height: 1024/768 05:16:22 INFO - PID 22206 | __metrics 05:16:32 INFO - PID 22206 | RSS: Main: 172105728 05:16:32 INFO - PID 22206 | 05:19:31 INFO - PID 22206 | Cycle 1(1): loaded http://localhost:42795/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42795/tests/dromaeo/cssquery-ext.html) 05:19:32 INFO - PID 22206 | RSS: Main: 176390144 05:19:32 INFO - PID 22206 | 05:22:34 INFO - PID 22206 | Cycle 1(1): loaded http://localhost:42795/tests/dromaeo/cssquery-ext.html (next: http://localhost:42795/tests/dromaeo/cssquery-jquery.html) 05:22:35 INFO - PID 22206 | RSS: Main: 172728320 05:22:35 INFO - PID 22206 | 05:25:36 INFO - PID 22206 | Cycle 1(1): loaded http://localhost:42795/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42795/tests/dromaeo/cssquery-mootools.html) 05:25:37 INFO - PID 22206 | RSS: Main: 174948352 05:25:37 INFO - PID 22206 | 05:28:39 INFO - PID 22206 | Cycle 1(1): loaded http://localhost:42795/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42795/tests/dromaeo/cssquery-prototype.html) 05:28:39 INFO - PID 22206 | RSS: Main: 173486080 05:28:39 INFO - PID 22206 | 05:31:43 INFO - PID 22206 | Cycle 1(1): loaded http://localhost:42795/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42795/tests/dromaeo/cssquery-yui.html) 05:31:44 INFO - PID 22206 | RSS: Main: 175083520 05:31:44 INFO - PID 22206 | 05:34:45 INFO - PID 22206 | Cycle 1(1): loaded http://localhost:42795/tests/dromaeo/cssquery-yui.html (next: http://localhost:42795/tests/dromaeo/cssquery-dojo.html) 05:34:46 INFO - PID 22206 | RSS: Main: 177872896 05:34:46 INFO - PID 22206 | 05:34:46 INFO - PID 22206 | __start_tp_report 05:34:46 INFO - PID 22206 | _x_x_mozilla_page_load 05:34:46 INFO - PID 22206 | _x_x_mozilla_page_load_details 05:34:46 INFO - PID 22206 | |i|pagename|runs| 05:34:46 INFO - PID 22206 | |0;dojo.html;3273.8690452381898;3299.2906525097114;3305.6198537168234;3323.1027622541906;3356.4294070008095;6249.59377640453;6275.52933529986;6311.652859092754;6337.461315788158;6433.292337842845;6179.134921111036;6266.561340706153;6271.560990730651;6274.592151510149;6284.842878928018;5737.885242295151;5758.280214973129;5771.336296325913;5772.5670574706855;5874.765009399619;5799.9130013049835;5845.620034697752;5851.882962340772;5855.677937713424;5869.354371019184;5647.3505546862225;5648.858778530528;5665.490105890469;5745;5789.855253618651;5667.6316039457715;5669.348024977139;5677.403872593401;5708.80019199326;5727.484526392603;5647.322321321427;5716.914246286267;5746.281714785652;5799.39106393831;5813;6014.75940962361;6117.84705382369;6132.6013809102715;6151.077338399231;6284.12022316876;6637.800865974028;6644.833879153011;6722.596644201363;6725.831854203635;6737.09049278351;6744.7976560703255;6751.628660423675;6751.932480675179;6758.729650813962;6766.120404347453;6223.751049957997;6295.527835412317;6314.652694101823;6339.683015849189;6407.935920640827;6915.343042410963;6916.446684265246;6984.266652001568;6986.790396288018;6990.685419156151;6580.341965803382;6589.110470086573;6616.834579135464;6694.163229596301;6714.3957043866285;6603.075569420285;6710.295418981034;6738.35985581369;6812.659367031629;6818.147731533559;6713.328667133345;6746.257911629717;6765.120534330604;6781.186257649015;6785.287544807823;6565.179352580927;6736.326367363323;6764.729410823512;6770.695318710571;6771.695273712695;5167.121589329823;5296.655717378435;5309.65487243328;5311.415744268127;5360.758765855468;4523.95476045242;4629.305604159403;4634.2585186370015;4654.115718013567;4679.157751604744;5898.4101589840675;5917.437843404869;5919.378465261172;5939.168516407706;5982.940170598238;6756;6770.322967703289;6787.864242715118;6842.897356539655;6875.7937261882225;5917.497012753878;5937.050071988461;6007.15899774032;6008.429199226067;6009.2188015557695;5740.024195886709;5742.08126699726;5803.651780893076;5811.912821307684;5823.388544202882;6378.075179099004;6459.031145328238;6487.610743355413;6516.478681705452;6608.107905432705;6755.763548275787;6764.120664313607;6768.932310676831;6802.14973128359;6812.284710105368;6521.8695626088165;6534.379233972765;6560.80317590454;6570.638614876228;6579.17760279965;6614.503912206507;6651.135352404156;6735.225449073223;6745.156855393076;6755.527113102035;6585.604863708193;6662.367075127855;6715.832104197434;6733.865322693617;6864.3822056013205;6502.479801615765;6519.706613202323;6531.379518945692;6532.216134063943;6576.145101136822;6479.643619600779;6486.935130648633;6566.080748695282;6566.244881838458;6605.47156227491;6424.678766061772;6434.549581529248;6504.317046710027;6505.284418714033;6521.02184672303;6416.711247993758;6546.639934803631;6574.934250657432;6662.766803161866;6679.4990375721045;6452.322506136976;6461.19235095613;6471.06169605414;6512.479001679949;6513.446357059703 05:34:46 INFO - PID 22206 | |1;ext.html;792.635387721648;846.2087947768837;859.9828003439935;873.70294100006;1113.3153110836827;28872;29341.853290733543;37502.81248593757;38486.80756596213;38585.03537411566;38666.8066659667;38965.80517097418;39074.8046259769;39078.80460597693;39132.41301380475;7489.700411983514;7729.53622782632;7739.806504837396;7751.147373788879;7762.184970578092;7413.147488038863;7632.961835190817;7637.656305466267;7650.885236721454;7652.502587331834;7634.5037572557885;7716.537007779523;7743.690252389898;7750.728724494616;7753.2634399732215;7566.01641786567;7630.504017238862;7633.618319084024;7639.04511936008;7662.348700360476;7556.055493063367;7637.847243055107;7639.388848892076;7641;7641.3504852087635;34605.65394346049;34800.47799283013;34889.302213955576;34956;35006.124846878774;3477.1654802847133;3506.3162683276773;3513.7540372173958;3515.6835884770494;3522.6477352264824;29430.558541621893;29446.558301625493;29508;29522.409551809058;29627;4957.479464656195;5113.923291150636;5148.768305426227;5160.174372100446;5231.869203269949;180719;181411;182128;182480;183403;45339.77330113328;45421.318680219825;45593.544064559595;45648;45737.542624573325;48184.7590762051;48252.75873620679;48516.27225591619;48595.5140448591;48814;12598.307093109783;12850.550230742067;15439.768403473958;15675.608109797346;15718.528444146694;12700.87299126997;12923.935380323039;12932.094753367173;12946.093773435958;12955.157914735511;13549.66125846842;13652.317384130754;13661.726765464833;13693.178409295475;13734.313284335743;5562.276904002454;5574.1917421973585;5647.37878833328;5674.829755107354;5729.942700572941;947.8530827721714;988.5551501824208;991.3407583956732;993.4536005197112;1018.180364806338;21855.890720546297;21902.780972190394;22096.668549971764;22127.557448851254;22333.55332893333;1089.4171618184391;1092.448313601626;1095.8411030400707;1105.8230683090828;1107.9667609971714;11697.590584329508;11720.824187637192;11744.647660570197;11818.231814932002;11888.465019074163;239277;239683;239876;240454;240567;53822;54275.45724542704;54285.72857135689;54325.72837135789;54570;1472.4110355857742;1479.0681870421565;1480.9185494797673;1489;1490.3516970118033;26479.867600661873;26826.731732682423;26945.59581606238;26985.460290793682;27223;36253.27493450169;36269.81865090658;36381.63618363888;36523.81738091292;36746.816265918496;202322;202906;202988;203173;204180;30115.247118822204;30528.542071868495;30804;32608.34783304273;33700.662993369755;39073.60926390813;40174;40211.59788402078;40432.39351409672;40574;30311.484425779065;30501.23746906345;31051.068467946;31058;31067.84466077655;29830.105096847128;30275.24311892132;30330.42611512584;30365.24086897757;30414.695853041187;34763.304733904675;34969.65030349664;35012.64987350094;35188.82405587956;35284.117897052776;29369.53152342417;29767.404651906407;29976.400471990873;29992.250193744458;30291.69708302977;21974.670379943993;22237.66643500381;22485.32544023682;22638.660420094042;23631.52736945286 05:34:46 INFO - PID 22206 | |2;jquery.html;532.1963834609741;541.5829811045497;543.6819460615541;545.3837164004674;553.8283132229009;21686.674699879495;21979.780202197973;22524.43688907778;22576.322710318676;22585.77414225857;25224.87387563064;25971;25985.09052183174;26130.216093517178;26147.47705045898;6982.720691172347;7177.820554486154;7178.389836863873;7179.533330333537;7193.568385896863;6615.437687796543;6967.4774391920555;6971.721131154748;6973.267806880255;6980.057692211537;6843.144606924135;6897.068895699066;6909.309069093076;6916.135483064617;6919.515633905628;6837.247902730695;6842.1105256316605;6853.143357080365;6853.7943861684225;6857.55425897315;6751.358620931003;6775.932240677579;6807.0810440590385;6832.45340372769;6836.4530837532875;29393.412131757457;30057;30531.2367190822;30594;30733.538996915064;2071.6892466130203;2108.061912448961;2112.524681946565;2119.9046042928107;2122.7028216049766;20292.289769858133;21043.5791284175;21111.15555377783;21196.940152992287;21295.254666086614;2523.596224604073;2549.4646124313917;2605.231456720272;2627.238100950722;2635.45973075521;139418;141466.29266853703;143553.28223358816;148075;149140;20608.58782824335;21326.253581124587;21542.461438464165;21561.353159405244;22214.66677999831;42312.576874230865;42343;42651.36022959658;42697.35953960693;42974.78512607479;11503.942480287713;11782.82325765097;11862.406879655982;11869.347185904859;12119.697007574705;9759.99920016395;9847.409155450696;9998;10032.749181270527;10036.397816131055;11207.159463040141;11274.661760147208;11315.886841131483;11517.942410288062;11833.940830295793;3709.956147798858;3722.683571896365;3774;4092.3656833190903;4385.90352411897;924.1867156901883;962.279249859592;962.31675510387;971.5142428785607;979.0307595480423;19663.705044424347;19788.802111978985;20174.495637609176;20515.4871128223;23232.07071717146;988.5600907596195;1025.7999690060367;1034.534459493231;1043.9791204175874;1052.0636633396284;10821.188410869216;11177.944110279559;11178.329300242012;11217.214794964275;11394.681882226021;549969;551295;551516;557682;567180;121519;122875;126049;126353;127832;1057.471264367816;1122.859642544682;1174.682835634374;1223.2966044524435;1234.5679012345786;20354.389368318974;20923.37229883106;21848.672269916282;21865.234716784835;21968.231111911005;56320;57076;57683.4231657678;58639.4136058651;60932.390676094445;69506;70090.64954675194;70099.29900701132;70151.29848701652;70950.64524677343;14278.42886284537;14527.709445811235;14573.271336433349;14642.341094650554;14686.779698304748;22991.65512517347;23011.769882301633;23108.653370199125;23128.76871231266;23288.301350959497;18149.455516334532;18299.542511436786;18387.908060459613;18651.90674046621;18806.717899231247;16471.423500177436;16489.91755041217;16965.406210782563;16998.830011699723;17414.82585174183;18792.812071879107;18928.14823332926;19128.71306930425;19180.712289315394;19240.518987025436;14355.784663230268;14480.782788258395;14510.274486275855;14570.34433450476;14613.123212607277;18316.450506484827;18427.53931151732;18476.630467390307;18678.813211867706;18723.812761872206 05:34:46 INFO - PID 22206 | |3;mootools.html;1308.5616318533291;1371.7050834070685;1383.0802516326644;1384.6676797568584;1385.3350391811923;12352.135350525466;14386.42454301828;15058.472953446619;15063.849361506382;15097.773533396994;12374.319412432335;14398.640033999156;14654.85345146551;14667.85332146681;14790.630234244123;2683.2621029216975;2707.2555047361934;2712.471068141713;2720.088770261965;2722.823016503931;2589.1067581684288;2664.2673264852224;2667.6932152802383;2668.7064422913463;2668.83986960782;2673.665791776028;2708.0386462805714;2711.024031348713;2712.593111033341;2713.74219449152;2551.7448255174518;2557.7825884799813;2573.6010918307693;2575.4720282342073;2576.8711564421797;2455.7789798918006;2480.2435257246534;2485.8135639827087;2498.1756020513185;2514.6228065790096;14026.509072182527;14082.71834563303;14148.221847798366;14149.717005659932;14152.363143658456;7472.887906681404;7772.106207786064;7796.688132474695;7798.298153166185;7807.6876924922935;5087.694738315676;5177.715225662587;5243.082460569385;5502.0921547944545;5516.503514683657;1942.873713208637;1965.1942703491643;1980.8514361422806;1982.9405117846343;2013.798620137989;24921.750782492123;25076;25113.121040763668;25116;25122.12072577451;7041.92958070423;7157.852644206717;7326.157491888394;7346.77959661211;7363.226861179606;16444.506664800076;16583.83416165823;16627.168641567874;16644.167791610373;16704.74942875858;7620.466567340233;7789.532628042336;7789.571573563395;7791.10402303731;7804.648790804427;5480.588955828249;6016.969915150396;7163.67763450646;7167.319104685047;7184.712611495586;5008.874778130576;5186.766595503212;5192.766325515361;5195.19474481456;5260.736963151904;1390.0817665953496;1401.9158850469005;1402.7194561087824;1412.2656218766183;1416.2281556551704;899.869518919766;911.252772726358;920.1120918313859;928.2852203803034;928.4382948316306;7752.844943101107;7829.804254893673;7863.842723145505;7895;7904.249096335839;700.0409439068509;718.8202949262684;721.1094298541298;725.6045455226914;735.3492159438935;4867.367242258484;4898.069366820293;5418.485243901823;5421.620486565981;5504.2294078829;20743.58512829735;21025.15899364039;21055.368338949855;21109.26117585877;21326.78673213279;20121.39635810928;20340.49148771263;20698.172073116908;21086;21128;10490.423026733602;10676.83984740214;10780.51487683056;10827.133829293794;10834.079103276152;8231;8341.499510029418;8391.664333426594;8413.411061225655;8422;17925.28298868083;18065.187066582297;18303.816961830213;18435.53911152232;18609.53476163107;17974.730379044588;18293;18519.81480185235;18546.979916104203;18740.812591873906;10653;10693.51879165455;10833.891661083288;10861.185411094042;10885.891141088488;13194.538191163263;13441.932790336377;13442.798358024833;13444.327783610976;13470.52853150135;10651.360918344924;10719;10739.570417183226;10867.891321086689;10953.56185752561;10706.839397408889;10879.945600271947;11026.944865275944;11099.056580190774;11148.832767508657;9936.403815771077;9964.900350996397;9992.450415226942;10043.246756493147;10093.343932644355;7371.447141464304;7422.814429639302;7457.403407727477;7498.062742157231;7499.625018748931;7547.358474529727;7688.692452301845;7714.5756983366455;7741.341985931259;7892.84214315699 05:34:46 INFO - PID 22206 | |4;prototype.html;496.0011155045169;500.8622628777088;515.466492180593;525.2462716002539;533.1815662957362;6435.613863168213;6454.419102280794;6454.580452270605;6512.4464420524255;6541.869162616751;6098.542609304309;6163.63018218906;6214.69491406804;6310.148130002448;6318;5068.265101560262;5068.5438310552045;5089.524038028986;5096.184610462326;5105.234214867781;5003.249512573107;5042.142835717937;5058.898822023557;5059.215821547666;5078.898422031557;4863;4976.104301225778;4983.476734942833;5026.447090820006;5050.545450909417;5008.54923056923;5014.122528557488;5027.346444962168;5040.34475518184;5053.797848086072;4510.413646225969;4517.570830771071;4526.343680166357;4535.299262776459;4548.135854187693;6210.782622608187;6223.20812974012;6254.593451425689;6264.749410023594;6280.277768056686;5768.134779783024;5807.1835159947395;5809.302883653946;5811.285670727146;5818.738156782955;6605.438537724299;6634.004899265149;6674.432673222782;6692.196936367667;6705.731770729165;4900.79464241093;4904.027737532574;4907.533784290486;4911.568773457162;4913.852584422473;7008.719651213945;7034.402075823612;7077.823054423629;7085.149782026138;7113.181984071794;5040.798368065236;5046.293518907356;5056.696598204119;5070.4929507049;5084.3644544431945;5098.419489958125;5103.897922041539;5106.285120083191;5124.333836601292;5134.486551344836;5742.856428589235;5770.16332631766;5784.132380142928;5801.245838041028;5828.125781132864;6694.297098804653;6720.596764194164;6737.764178253738;6739.258681545026;6790.49071319653;1687.8396552327508;1695.8982461052376;1723.2676112652073;1755.4733579925971;1786.7141257398753;1204.795184818583;1226.3255209634665;1226.4848763519344;1229.956951506693;1232.8732935686048;5778.191053252548;5829.854253643693;5859.560532960045;5879.323877754027;5911.733971971272;6655.866882662416;6776.290478117661;6794.048833163361;6819.737663960025;6875.5530890491955;5870.911936320958;5878.2358293421585;5889.646621202742;5897.852553686193;5914.172015917775;3602.4056030755155;3605.549306336708;3624.836882340301;3625.148090198801;3640.287985450856;6612.0412540181405;6648.404382948058;6652.168478940132;6657.900131498031;6685.966570167216;7058;7077.646117694095;7092.326229008236;7143.24995875436;7169.749058782918;6511.34886511345;6690.69891854858;6696.732130714814;6699.196096468455;6736.292689267556;6889.448844092561;6926.229508196761;6936.745557693871;6947.3747362737595;6952.617606031717;6708.98730380874;6791.320867913169;6801.047853300641;6826.965865170642;6865.965670171618;6608.636524991171;6613.768518101843;6654.700538475683;6664.7673029535645;6724.428423583854;5058.418281897629;5073.213651883964;5076;5090.618203634668;5093.821716240062;6810.829729256809;6916.827079322856;6949.339812717783;6957;6972.860542789217;6658.866822663616;6679.432248258952;6717.458097069839;6761.425278851353;6775.1531058617675;6549.869002619826;6554.573952693059;6651.401373876374;6653.567518111307;6660.167479065117;6287.862126876884;6422.935770642421;6552.443042341454;6555.70499327541;6587.934120658923;6587.948411726849;6654.334566543307;6659.633720145439;6709.295523969913;6768.763093291711;6320.241571011508;6326.620402775849;6350.523710721806;6394.424501794861;6492.091107245084 05:34:46 INFO - PID 22206 | |5;yui.html;872.8996165440976;874.6982291109568;881.982360352793;885.5306687455651;895.5522238880558;18522.07389630518;19617.705734413976;19699.21203151872;19723.605527889435;20943.68584471234;20744.48138796531;21458.57082858346;21523.139074437004;21678.024488897998;21796.237131700393;921.1387352825113;942.6983365323099;942.8255772682041;945.5697657565792;949.178960199426;935.8736570562955;956.4022485946283;965.7923546437514;970.6554173268494;972.4408465132577;1014.7158795537262;1014.7919676466307;1015.1117771949545;1016.7559785651428;1017.0338178730199;991.3902949685963;994.7910938702809;995.4574756757548;998.2962011781676;1003.6687892995294;731.893875388071;736.9705211791522;737.2553720742036;737.6016950846537;737.6754228139602;19300.1314940828;19510.80489195104;19705;19746.11142498591;20017.899910500353;20659.793402065938;20944.581108377748;21435.14259429621;21437.46406339854;21459.463513412134;16857.915710421494;17066.914665426717;17197.312107515685;17212.053337066456;17470.301187952467;3716.2567486502808;3743.5507739071486;3745.045013521562;3747.1006958330076;3747.4378843173467;126208;126835;127338.36330818379;128568.35715821455;129425;16393.262303196385;16408.83591164097;16414.753778693328;16760.497185084467;17104.315827367016;28891.855540722583;29378.11865644034;29439.26401839971;29697.703022969927;30267;7747;8026.478278911852;8505.192006759347;8850.070742572067;9205.355625106178;4187.267228235108;4358.302671572533;4378;4392.670549708785;4396.934045989313;5086.516780905808;5150.27896094547;5247.396549396792;5254.579633629377;5289.788408463618;1065.174489770434;1072.3887384191091;1089.1014912696899;1090.3948308688755;1091.5197313182175;657.7927952694886;664.7141729056456;681.0907438569565;690.8721886451023;693.3794254142514;11558.595449159238;11844.155844155845;12628.305443200712;12818.359082045861;13254.73490530184;690.0994202565599;690.3821080133253;693.774523279936;696.20632478974;706.780897921646;5342.5993050521365;5382.91925621116;5498.3127109111365;5510.889782204334;5512.972435137799;110441.44779276213;110897;111904;117655.41172294084;118033;97932.51033744785;98350;100486;102014;102047.4897625522;84973;87627.56186219028;87853.12146878577;88232.11767882368;89473;12785.232886026868;12911;13022.609321720363;13024.804627930778;13130.212187268413;40058;40661.39007914943;40695.38956915708;40712.796436017634;40889.1822163561;50793.746031269606;52104.21843672424;52175.73912130415;53092;53183.20225196548;17927.10364481797;18182.181801818686;18218.72671909896;18276.81723182751;18292.542686432946;19805.702914456007;20028;20087.598248034665;20114.798852011878;20249;18832.24671013144;18953.71569426432;19016.619667606847;19239.903800480908;19244.23023079117;17281.913590431966;17434.21546030406;17549.034803085953;17735.733963990293;17793.288268469118;17562.29750809953;17692.469225923243;17702.734458982868;17796.91101544536;17887.37394191197;13891.235982021086;14040.244969378828;14089.788653170415;14126.858731412554;14473.276336182938;13563.186208827501;13629.727405452033;13630.795538067136;13756.17462952186;14015.929920350332 05:34:46 INFO - PID 22206 | __end_tp_report 05:34:46 INFO - PID 22206 | __start_cc_report 05:34:46 INFO - PID 22206 | _x_x_mozilla_cycle_collect,388 05:34:46 INFO - PID 22206 | __end_cc_report 05:34:46 INFO - PID 22206 | __startTimestamp1503578086054__endTimestamp 05:34:46 INFO - PID 22206 | 05:34:46 INFO - PID 22206 | ------- Summary: start ------- 05:34:46 INFO - PID 22206 | Number of tests: 6 05:34:46 INFO - PID 22206 | 05:34:46 INFO - PID 22206 | [#0] dojo.html Cycles:165 Average:6200.80 Median:6471.06 stddev:724.97 (11.2%) stddev-sans-first:689.88 05:34:46 INFO - PID 22206 | Values: 3273.9 3299.3 3305.6 3323.1 3356.4 6249.6 6275.5 6311.7 6337.5 6433.3 6179.1 6266.6 6271.6 6274.6 6284.8 5737.9 5758.3 5771.3 5772.6 5874.8 5799.9 5845.6 5851.9 5855.7 5869.4 5647.4 5648.9 5665.5 5745.0 5789.9 5667.6 5669.3 5677.4 5708.8 5727.5 5647.3 5716.9 5746.3 5799.4 5813.0 6014.8 6117.8 6132.6 6151.1 6284.1 6637.8 6644.8 6722.6 6725.8 6737.1 6744.8 6751.6 6751.9 6758.7 6766.1 6223.8 6295.5 6314.7 6339.7 6407.9 6915.3 6916.4 6984.3 6986.8 6990.7 6580.3 6589.1 6616.8 6694.2 6714.4 6603.1 6710.3 6738.4 6812.7 6818.1 6713.3 6746.3 6765.1 6781.2 6785.3 6565.2 6736.3 6764.7 6770.7 6771.7 5167.1 5296.7 5309.7 5311.4 5360.8 4524.0 4629.3 4634.3 4654.1 4679.2 5898.4 5917.4 5919.4 5939.2 5982.9 6756.0 6770.3 6787.9 6842.9 6875.8 5917.5 5937.1 6007.2 6008.4 6009.2 5740.0 5742.1 5803.7 5811.9 5823.4 6378.1 6459.0 6487.6 6516.5 6608.1 6755.8 6764.1 6768.9 6802.1 6812.3 6521.9 6534.4 6560.8 6570.6 6579.2 6614.5 6651.1 6735.2 6745.2 6755.5 6585.6 6662.4 6715.8 6733.9 6864.4 6502.5 6519.7 6531.4 6532.2 6576.1 6479.6 6486.9 6566.1 6566.2 6605.5 6424.7 6434.5 6504.3 6505.3 6521.0 6416.7 6546.6 6574.9 6662.8 6679.5 6452.3 6461.2 6471.1 6512.5 6513.4 05:34:46 INFO - PID 22206 | 05:34:46 INFO - PID 22206 | [#1] ext.html Cycles:180 Average:36851.58 Median:19120.24 stddev:54409.90 (284.6%) stddev-sans-first:54495.16 05:34:46 INFO - PID 22206 | Values: 792.6 846.2 860.0 873.7 1113.3 28872.0 29341.9 37502.8 38486.8 38585.0 38666.8 38965.8 39074.8 39078.8 39132.4 7489.7 7729.5 7739.8 7751.1 7762.2 7413.1 7633.0 7637.7 7650.9 7652.5 7634.5 7716.5 7743.7 7750.7 7753.3 7566.0 7630.5 7633.6 7639.0 7662.3 7556.1 7637.8 7639.4 7641.0 7641.4 34605.7 34800.5 34889.3 34956.0 35006.1 3477.2 3506.3 3513.8 3515.7 3522.6 29430.6 29446.6 29508.0 29522.4 29627.0 4957.5 5113.9 5148.8 5160.2 5231.9 180719.0 181411.0 182128.0 182480.0 183403.0 45339.8 45421.3 45593.5 45648.0 45737.5 48184.8 48252.8 48516.3 48595.5 48814.0 12598.3 12850.6 15439.8 15675.6 15718.5 12700.9 12923.9 12932.1 12946.1 12955.2 13549.7 13652.3 13661.7 13693.2 13734.3 5562.3 5574.2 5647.4 5674.8 5729.9 947.9 988.6 991.3 993.5 1018.2 21855.9 21902.8 22096.7 22127.6 22333.6 1089.4 1092.4 1095.8 1105.8 1108.0 11697.6 11720.8 11744.6 11818.2 11888.5 239277.0 239683.0 239876.0 240454.0 240567.0 53822.0 54275.5 54285.7 54325.7 54570.0 1472.4 1479.1 1480.9 1489.0 1490.4 26479.9 26826.7 26945.6 26985.5 27223.0 36253.3 36269.8 36381.6 36523.8 36746.8 202322.0 202906.0 202988.0 203173.0 204180.0 30115.2 30528.5 30804.0 32608.3 33700.7 39073.6 40174.0 40211.6 40432.4 40574.0 30311.5 30501.2 31051.1 31058.0 31067.8 29830.1 30275.2 30330.4 30365.2 30414.7 34763.3 34969.7 35012.6 35188.8 35284.1 29369.5 29767.4 29976.4 29992.3 30291.7 21974.7 22237.7 22485.3 22638.7 23631.5 05:34:46 INFO - PID 22206 | 05:34:46 INFO - PID 22206 | [#2] jquery.html Cycles:180 Average:38192.42 Median:22097.22 stddev:93000.72 (420.9%) stddev-sans-first:93218.63 05:34:46 INFO - PID 22206 | Values: 532.2 541.6 543.7 545.4 553.8 21686.7 21979.8 22524.4 22576.3 22585.8 25224.9 25971.0 25985.1 26130.2 26147.5 6982.7 7177.8 7178.4 7179.5 7193.6 6615.4 6967.5 6971.7 6973.3 6980.1 6843.1 6897.1 6909.3 6916.1 6919.5 6837.2 6842.1 6853.1 6853.8 6857.6 6751.4 6775.9 6807.1 6832.5 6836.5 29393.4 30057.0 30531.2 30594.0 30733.5 2071.7 2108.1 2112.5 2119.9 2122.7 20292.3 21043.6 21111.2 21196.9 21295.3 2523.6 2549.5 2605.2 2627.2 2635.5 139418.0 141466.3 143553.3 148075.0 149140.0 20608.6 21326.3 21542.5 21561.4 22214.7 42312.6 42343.0 42651.4 42697.4 42974.8 11503.9 11782.8 11862.4 11869.3 12119.7 9760.0 9847.4 9998.0 10032.7 10036.4 11207.2 11274.7 11315.9 11517.9 11833.9 3710.0 3722.7 3774.0 4092.4 4385.9 924.2 962.3 962.3 971.5 979.0 19663.7 19788.8 20174.5 20515.5 23232.1 988.6 1025.8 1034.5 1044.0 1052.1 10821.2 11177.9 11178.3 11217.2 11394.7 549969.0 551295.0 551516.0 557682.0 567180.0 121519.0 122875.0 126049.0 126353.0 127832.0 1057.5 1122.9 1174.7 1223.3 1234.6 20354.4 20923.4 21848.7 21865.2 21968.2 56320.0 57076.0 57683.4 58639.4 60932.4 69506.0 70090.6 70099.3 70151.3 70950.6 14278.4 14527.7 14573.3 14642.3 14686.8 22991.7 23011.8 23108.7 23128.8 23288.3 18149.5 18299.5 18387.9 18651.9 18806.7 16471.4 16489.9 16965.4 16998.8 17414.8 18792.8 18928.1 19128.7 19180.7 19240.5 14355.8 14480.8 14510.3 14570.3 14613.1 18316.5 18427.5 18476.6 18678.8 18723.8 05:34:46 INFO - PID 22206 | 05:34:46 INFO - PID 22206 | [#3] mootools.html Cycles:180 Average:9037.44 Median:13818.37 stddev:6371.94 (46.1%) stddev-sans-first:6363.35 05:34:46 INFO - PID 22206 | Values: 1308.6 1371.7 1383.1 1384.7 1385.3 12352.1 14386.4 15058.5 15063.8 15097.8 12374.3 14398.6 14654.9 14667.9 14790.6 2683.3 2707.3 2712.5 2720.1 2722.8 2589.1 2664.3 2667.7 2668.7 2668.8 2673.7 2708.0 2711.0 2712.6 2713.7 2551.7 2557.8 2573.6 2575.5 2576.9 2455.8 2480.2 2485.8 2498.2 2514.6 14026.5 14082.7 14148.2 14149.7 14152.4 7472.9 7772.1 7796.7 7798.3 7807.7 5087.7 5177.7 5243.1 5502.1 5516.5 1942.9 1965.2 1980.9 1982.9 2013.8 24921.8 25076.0 25113.1 25116.0 25122.1 7041.9 7157.9 7326.2 7346.8 7363.2 16444.5 16583.8 16627.2 16644.2 16704.7 7620.5 7789.5 7789.6 7791.1 7804.6 5480.6 6017.0 7163.7 7167.3 7184.7 5008.9 5186.8 5192.8 5195.2 5260.7 1390.1 1401.9 1402.7 1412.3 1416.2 899.9 911.3 920.1 928.3 928.4 7752.8 7829.8 7863.8 7895.0 7904.2 700.0 718.8 721.1 725.6 735.3 4867.4 4898.1 5418.5 5421.6 5504.2 20743.6 21025.2 21055.4 21109.3 21326.8 20121.4 20340.5 20698.2 21086.0 21128.0 10490.4 10676.8 10780.5 10827.1 10834.1 8231.0 8341.5 8391.7 8413.4 8422.0 17925.3 18065.2 18303.8 18435.5 18609.5 17974.7 18293.0 18519.8 18547.0 18740.8 10653.0 10693.5 10833.9 10861.2 10885.9 13194.5 13441.9 13442.8 13444.3 13470.5 10651.4 10719.0 10739.6 10867.9 10953.6 10706.8 10879.9 11026.9 11099.1 11148.8 9936.4 9964.9 9992.5 10043.2 10093.3 7371.4 7422.8 7457.4 7498.1 7499.6 7547.4 7688.7 7714.6 7741.3 7892.8 05:34:46 INFO - PID 22206 | 05:34:46 INFO - PID 22206 | [#4] prototype.html Cycles:180 Average:5612.19 Median:6259.67 stddev:1593.06 (25.4%) stddev-sans-first:1550.56 05:34:46 INFO - PID 22206 | Values: 496.0 500.9 515.5 525.2 533.2 6435.6 6454.4 6454.6 6512.4 6541.9 6098.5 6163.6 6214.7 6310.1 6318.0 5068.3 5068.5 5089.5 5096.2 5105.2 5003.2 5042.1 5058.9 5059.2 5078.9 4863.0 4976.1 4983.5 5026.4 5050.5 5008.5 5014.1 5027.3 5040.3 5053.8 4510.4 4517.6 4526.3 4535.3 4548.1 6210.8 6223.2 6254.6 6264.7 6280.3 5768.1 5807.2 5809.3 5811.3 5818.7 6605.4 6634.0 6674.4 6692.2 6705.7 4900.8 4904.0 4907.5 4911.6 4913.9 7008.7 7034.4 7077.8 7085.1 7113.2 5040.8 5046.3 5056.7 5070.5 5084.4 5098.4 5103.9 5106.3 5124.3 5134.5 5742.9 5770.2 5784.1 5801.2 5828.1 6694.3 6720.6 6737.8 6739.3 6790.5 1687.8 1695.9 1723.3 1755.5 1786.7 1204.8 1226.3 1226.5 1230.0 1232.9 5778.2 5829.9 5859.6 5879.3 5911.7 6655.9 6776.3 6794.0 6819.7 6875.6 5870.9 5878.2 5889.6 5897.9 5914.2 3602.4 3605.5 3624.8 3625.1 3640.3 6612.0 6648.4 6652.2 6657.9 6686.0 7058.0 7077.6 7092.3 7143.2 7169.7 6511.3 6690.7 6696.7 6699.2 6736.3 6889.4 6926.2 6936.7 6947.4 6952.6 6709.0 6791.3 6801.0 6827.0 6866.0 6608.6 6613.8 6654.7 6664.8 6724.4 5058.4 5073.2 5076.0 5090.6 5093.8 6810.8 6916.8 6949.3 6957.0 6972.9 6658.9 6679.4 6717.5 6761.4 6775.2 6549.9 6554.6 6651.4 6653.6 6660.2 6287.9 6422.9 6552.4 6555.7 6587.9 6587.9 6654.3 6659.6 6709.3 6768.8 6320.2 6326.6 6350.5 6394.4 6492.1 05:34:46 INFO - PID 22206 | 05:34:46 INFO - PID 22206 | [#5] yui.html Cycles:180 Average:23567.76 Median:20944.13 stddev:32187.43 (153.7%) stddev-sans-first:32232.61 05:34:46 INFO - PID 22206 | Values: 872.9 874.7 882.0 885.5 895.6 18522.1 19617.7 19699.2 19723.6 20943.7 20744.5 21458.6 21523.1 21678.0 21796.2 921.1 942.7 942.8 945.6 949.2 935.9 956.4 965.8 970.7 972.4 1014.7 1014.8 1015.1 1016.8 1017.0 991.4 994.8 995.5 998.3 1003.7 731.9 737.0 737.3 737.6 737.7 19300.1 19510.8 19705.0 19746.1 20017.9 20659.8 20944.6 21435.1 21437.5 21459.5 16857.9 17066.9 17197.3 17212.1 17470.3 3716.3 3743.6 3745.0 3747.1 3747.4 126208.0 126835.0 127338.4 128568.4 129425.0 16393.3 16408.8 16414.8 16760.5 17104.3 28891.9 29378.1 29439.3 29697.7 30267.0 7747.0 8026.5 8505.2 8850.1 9205.4 4187.3 4358.3 4378.0 4392.7 4396.9 5086.5 5150.3 5247.4 5254.6 5289.8 1065.2 1072.4 1089.1 1090.4 1091.5 657.8 664.7 681.1 690.9 693.4 11558.6 11844.2 12628.3 12818.4 13254.7 690.1 690.4 693.8 696.2 706.8 5342.6 5382.9 5498.3 5510.9 5513.0 110441.4 110897.0 111904.0 117655.4 118033.0 97932.5 98350.0 100486.0 102014.0 102047.5 84973.0 87627.6 87853.1 88232.1 89473.0 12785.2 12911.0 13022.6 13024.8 13130.2 40058.0 40661.4 40695.4 40712.8 40889.2 50793.7 52104.2 52175.7 53092.0 53183.2 17927.1 18182.2 18218.7 18276.8 18292.5 19805.7 20028.0 20087.6 20114.8 20249.0 18832.2 18953.7 19016.6 19239.9 19244.2 17281.9 17434.2 17549.0 17735.7 17793.3 17562.3 17692.5 17702.7 17796.9 17887.4 13891.2 14040.2 14089.8 14126.9 14473.3 13563.2 13629.7 13630.8 13756.2 14015.9 05:34:46 INFO - PID 22206 | -------- Summary: end -------- 05:34:46 INFO - PID 22206 | 05:34:46 INFO - TEST-INFO | 22206: exit 0 05:34:46 INFO - TEST-OK | dromaeo_css | took 1111207ms 05:34:46 INFO - TEST-START | kraken 05:34:46 INFO - Initialising browser for kraken test... 05:34:46 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42795/getInfo.html -profile /tmp/tmpX7hfdh/profile 05:34:46 INFO - TEST-INFO | started process 22612 (/builds/slave/test/build/application/firefox/firefox http://localhost:42795/getInfo.html) 05:34:52 INFO - TEST-INFO | 22612: exit 0 05:34:52 INFO - Browser initialized. 05:34:52 INFO - Running cycle 1/1 for kraken test... 05:34:52 INFO - TEST-INFO | started process 22790 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX7hfdh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:34:53 INFO - PID 22790 | 05:34:53 INFO - PID 22790 | (/builds/slave/test/build/application/firefox/firefox:22840): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:34:53 INFO - PID 22790 | 05:34:53 INFO - PID 22790 | 05:34:53 INFO - PID 22790 | (/builds/slave/test/build/application/firefox/firefox:22892): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:34:53 INFO - PID 22790 | 05:34:53 INFO - PID 22790 | __metrics Screen width/height:1600/1200 05:34:53 INFO - PID 22790 | colorDepth:24 05:34:53 INFO - PID 22790 | Browser inner width/height: 1024/768 05:34:53 INFO - PID 22790 | __metrics 05:35:03 INFO - PID 22790 | RSS: Main: 172134400 05:35:03 INFO - PID 22790 | 05:35:06 INFO - PID 22790 | Cycle 1(1): loaded http://localhost:42795/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42795/tests/kraken/driver.html?testName=audio-beat-detection) 05:35:07 INFO - PID 22790 | RSS: Main: 176291840 05:35:07 INFO - PID 22790 | 05:35:09 INFO - PID 22790 | Cycle 1(1): loaded http://localhost:42795/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42795/tests/kraken/driver.html?testName=audio-dft) 05:35:10 INFO - PID 22790 | RSS: Main: 176889856 05:35:10 INFO - PID 22790 | 05:35:13 INFO - PID 22790 | Cycle 1(1): loaded http://localhost:42795/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42795/tests/kraken/driver.html?testName=audio-fft) 05:35:14 INFO - PID 22790 | RSS: Main: 171495424 05:35:14 INFO - PID 22790 | 05:35:16 INFO - PID 22790 | Cycle 1(1): loaded http://localhost:42795/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42795/tests/kraken/driver.html?testName=audio-oscillator) 05:35:16 INFO - PID 22790 | RSS: Main: 172396544 05:35:16 INFO - PID 22790 | 05:35:18 INFO - PID 22790 | Cycle 1(1): loaded http://localhost:42795/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42795/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:35:19 INFO - PID 22790 | RSS: Main: 172081152 05:35:19 INFO - PID 22790 | 05:35:22 INFO - PID 22790 | Cycle 1(1): loaded http://localhost:42795/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42795/tests/kraken/driver.html?testName=imaging-darkroom) 05:35:23 INFO - PID 22790 | RSS: Main: 173268992 05:35:23 INFO - PID 22790 | 05:35:26 INFO - PID 22790 | Cycle 1(1): loaded http://localhost:42795/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42795/tests/kraken/driver.html?testName=imaging-desaturate) 05:35:27 INFO - PID 22790 | RSS: Main: 173137920 05:35:27 INFO - PID 22790 | 05:35:30 INFO - PID 22790 | Cycle 1(1): loaded http://localhost:42795/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42795/tests/kraken/driver.html?testName=json-parse-financial) 05:35:30 INFO - PID 22790 | RSS: Main: 173158400 05:35:30 INFO - PID 22790 | 05:35:32 INFO - PID 22790 | Cycle 1(1): loaded http://localhost:42795/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42795/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:35:33 INFO - PID 22790 | RSS: Main: 173285376 05:35:33 INFO - PID 22790 | 05:35:35 INFO - PID 22790 | Cycle 1(1): loaded http://localhost:42795/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42795/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:35:35 INFO - PID 22790 | RSS: Main: 173662208 05:35:35 INFO - PID 22790 | 05:35:37 INFO - PID 22790 | Cycle 1(1): loaded http://localhost:42795/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42795/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:35:38 INFO - PID 22790 | RSS: Main: 174247936 05:35:38 INFO - PID 22790 | 05:35:41 INFO - PID 22790 | Cycle 1(1): loaded http://localhost:42795/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42795/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:35:41 INFO - PID 22790 | RSS: Main: 174735360 05:35:41 INFO - PID 22790 | 05:35:44 INFO - PID 22790 | Cycle 1(1): loaded http://localhost:42795/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42795/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:35:45 INFO - PID 22790 | RSS: Main: 174252032 05:35:45 INFO - PID 22790 | 05:35:47 INFO - PID 22790 | Cycle 1(1): loaded http://localhost:42795/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42795/tests/kraken/driver.html?testName=ai-astar) 05:35:47 INFO - PID 22790 | RSS: Main: 175751168 05:35:47 INFO - PID 22790 | 05:35:47 INFO - PID 22790 | __start_tp_report 05:35:47 INFO - PID 22790 | _x_x_mozilla_page_load 05:35:47 INFO - PID 22790 | _x_x_mozilla_page_load_details 05:35:47 INFO - PID 22790 | |i|pagename|runs| 05:35:47 INFO - PID 22790 | |0;ai-astar;99;110;102;107;107;112;111;99;107;110 05:35:47 INFO - PID 22790 | |1;audio-beat-detection;150;118;146;169;118;140;149;126;174;119 05:35:47 INFO - PID 22790 | |2;audio-dft;161;164;164;164;162;163;162;171;165;166 05:35:47 INFO - PID 22790 | |3;audio-fft;79;74;74;170;75;76;81;75;166;75 05:35:47 INFO - PID 22790 | |4;audio-oscillator;79;79;134;80;80;79;131;80;79;130 05:35:47 INFO - PID 22790 | |5;imaging-gaussian-blur;114;115;115;115;114;115;116;116;114;114 05:35:47 INFO - PID 22790 | |6;imaging-darkroom;154;150;148;150;149;148;150;148;149;148 05:35:47 INFO - PID 22790 | |7;imaging-desaturate;96;95;95;95;94;94;95;94;94;94 05:35:47 INFO - PID 22790 | |8;json-parse-financial;53;52;52;53;52;52;52;53;52;52 05:35:47 INFO - PID 22790 | |9;json-stringify-tinderbox;56;55;56;55;55;56;55;55;56;56 05:35:47 INFO - PID 22790 | |10;stanford-crypto-aes;75;81;75;86;80;74;75;75;76;81 05:35:47 INFO - PID 22790 | |11;stanford-crypto-ccm;128;121;119;123;135;128;118;116;124;164 05:35:47 INFO - PID 22790 | |12;stanford-crypto-pbkdf2;178;170;176;177;174;173;179;172;178;184 05:35:47 INFO - PID 22790 | |13;stanford-crypto-sha256-iterative;66;65;66;65;63;65;64;62;64;69 05:35:47 INFO - PID 22790 | __end_tp_report 05:35:47 INFO - PID 22790 | __start_cc_report 05:35:47 INFO - PID 22790 | _x_x_mozilla_cycle_collect,984 05:35:47 INFO - PID 22790 | __end_cc_report 05:35:47 INFO - PID 22790 | __startTimestamp1503578147420__endTimestamp 05:35:47 INFO - PID 22790 | 05:35:47 INFO - PID 22790 | ------- Summary: start ------- 05:35:47 INFO - PID 22790 | Number of tests: 14 05:35:47 INFO - PID 22790 | 05:35:47 INFO - PID 22790 | [#0] ai-astar Cycles:10 Average:106.40 Median:110.50 stddev:4.81 (4.4%) stddev-sans-first:4.29 05:35:47 INFO - PID 22790 | Values: 99.0 110.0 102.0 107.0 107.0 112.0 111.0 99.0 107.0 110.0 05:35:47 INFO - PID 22790 | 05:35:47 INFO - PID 22790 | [#1] audio-beat-detection Cycles:10 Average:140.90 Median:147.50 stddev:20.58 (14.0%) stddev-sans-first:21.56 05:35:47 INFO - PID 22790 | Values: 150.0 118.0 146.0 169.0 118.0 140.0 149.0 126.0 174.0 119.0 05:35:47 INFO - PID 22790 | 05:35:47 INFO - PID 22790 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.00 stddev:2.82 (1.7%) stddev-sans-first:2.74 05:35:47 INFO - PID 22790 | Values: 161.0 164.0 164.0 164.0 162.0 163.0 162.0 171.0 165.0 166.0 05:35:47 INFO - PID 22790 | 05:35:47 INFO - PID 22790 | [#3] audio-fft Cycles:10 Average:94.50 Median:75.00 stddev:38.81 (51.8%) stddev-sans-first:40.76 05:35:47 INFO - PID 22790 | Values: 79.0 74.0 74.0 170.0 75.0 76.0 81.0 75.0 166.0 75.0 05:35:47 INFO - PID 22790 | 05:35:47 INFO - PID 22790 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:79.00 stddev:25.26 (32.0%) stddev-sans-first:26.11 05:35:47 INFO - PID 22790 | Values: 79.0 79.0 134.0 80.0 80.0 79.0 131.0 80.0 79.0 130.0 05:35:47 INFO - PID 22790 | 05:35:47 INFO - PID 22790 | [#5] imaging-gaussian-blur Cycles:10 Average:114.80 Median:115.00 stddev:0.79 (0.7%) stddev-sans-first:0.78 05:35:47 INFO - PID 22790 | Values: 114.0 115.0 115.0 115.0 114.0 115.0 116.0 116.0 114.0 114.0 05:35:47 INFO - PID 22790 | 05:35:47 INFO - PID 22790 | [#6] imaging-darkroom Cycles:10 Average:149.40 Median:149.50 stddev:1.84 (1.2%) stddev-sans-first:0.93 05:35:47 INFO - PID 22790 | Values: 154.0 150.0 148.0 150.0 149.0 148.0 150.0 148.0 149.0 148.0 05:35:47 INFO - PID 22790 | 05:35:47 INFO - PID 22790 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.53 05:35:47 INFO - PID 22790 | Values: 96.0 95.0 95.0 95.0 94.0 94.0 95.0 94.0 94.0 94.0 05:35:47 INFO - PID 22790 | 05:35:47 INFO - PID 22790 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:52.00 stddev:0.48 (0.9%) stddev-sans-first:0.44 05:35:47 INFO - PID 22790 | Values: 53.0 52.0 52.0 53.0 52.0 52.0 52.0 53.0 52.0 52.0 05:35:47 INFO - PID 22790 | 05:35:47 INFO - PID 22790 | [#9] json-stringify-tinderbox Cycles:10 Average:55.50 Median:56.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 05:35:47 INFO - PID 22790 | Values: 56.0 55.0 56.0 55.0 55.0 56.0 55.0 55.0 56.0 56.0 05:35:47 INFO - PID 22790 | 05:35:47 INFO - PID 22790 | [#10] stanford-crypto-aes Cycles:10 Average:77.80 Median:78.00 stddev:3.97 (5.1%) stddev-sans-first:4.08 05:35:47 INFO - PID 22790 | Values: 75.0 81.0 75.0 86.0 80.0 74.0 75.0 75.0 76.0 81.0 05:35:47 INFO - PID 22790 | 05:35:47 INFO - PID 22790 | [#11] stanford-crypto-ccm Cycles:10 Average:127.60 Median:126.00 stddev:13.98 (11.1%) stddev-sans-first:14.82 05:35:47 INFO - PID 22790 | Values: 128.0 121.0 119.0 123.0 135.0 128.0 118.0 116.0 124.0 164.0 05:35:47 INFO - PID 22790 | 05:35:47 INFO - PID 22790 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.10 Median:177.50 stddev:4.04 (2.3%) stddev-sans-first:4.23 05:35:47 INFO - PID 22790 | Values: 178.0 170.0 176.0 177.0 174.0 173.0 179.0 172.0 178.0 184.0 05:35:47 INFO - PID 22790 | 05:35:47 INFO - PID 22790 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:1.91 (2.9%) stddev-sans-first:1.99 05:35:47 INFO - PID 22790 | Values: 66.0 65.0 66.0 65.0 63.0 65.0 64.0 62.0 64.0 69.0 05:35:47 INFO - PID 22790 | -------- Summary: end -------- 05:35:47 INFO - PID 22790 | 05:35:47 INFO - PID 22790 | 05:35:47 INFO - PID 22790 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150081,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 05:35:47 INFO - PID 22790 | 05:35:47 INFO - PID 22790 | 05:35:47 INFO - PID 22790 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 05:35:47 INFO - PID 22790 | 05:35:47 INFO - PID 22790 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 05:35:48 INFO - TEST-INFO | 22790: exit 0 05:35:48 INFO - TEST-OK | kraken | took 61321ms 05:35:48 INFO - SUITE-END | took 1172s 05:35:48 INFO - Completed test suite (00:19:32) 05:35:48 INFO - javascript benchmark 05:35:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8587.187238879198, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3273.8690452381898, 3299.2906525097114, 3305.6198537168234, 3323.1027622541906, 3356.4294070008095, 6249.59377640453, 6275.52933529986, 6311.652859092754, 6337.461315788158, 6433.292337842845, 6179.134921111036, 6266.561340706153, 6271.560990730651, 6274.592151510149, 6284.842878928018, 5737.885242295151, 5758.280214973129, 5771.336296325913, 5772.5670574706855, 5874.765009399619, 5799.9130013049835, 5845.620034697752, 5851.882962340772, 5855.677937713424, 5869.354371019184, 5647.3505546862225, 5648.858778530528, 5665.490105890469, 5745.0, 5789.855253618651, 5667.6316039457715, 5669.348024977139, 5677.403872593401, 5708.80019199326, 5727.484526392603, 5647.322321321427, 5716.914246286267, 5746.281714785652, 5799.39106393831, 5813.0, 6014.75940962361, 6117.84705382369, 6132.6013809102715, 6151.077338399231, 6284.12022316876, 6637.800865974028, 6644.833879153011, 6722.596644201363, 6725.831854203635, 6737.09049278351, 6744.7976560703255, 6751.628660423675, 6751.932480675179, 6758.729650813962, 6766.120404347453, 6223.751049957997, 6295.527835412317, 6314.652694101823, 6339.683015849189, 6407.935920640827, 6915.343042410963, 6916.446684265246, 6984.266652001568, 6986.790396288018, 6990.685419156151, 6580.341965803382, 6589.110470086573, 6616.834579135464, 6694.163229596301, 6714.3957043866285, 6603.075569420285, 6710.295418981034, 6738.35985581369, 6812.659367031629, 6818.147731533559, 6713.328667133345, 6746.257911629717, 6765.120534330604, 6781.186257649015, 6785.287544807823, 6565.179352580927, 6736.326367363323, 6764.729410823512, 6770.695318710571, 6771.695273712695, 5167.121589329823, 5296.655717378435, 5309.65487243328, 5311.415744268127, 5360.758765855468, 4523.95476045242, 4629.305604159403, 4634.2585186370015, 4654.115718013567, 4679.157751604744, 5898.4101589840675, 5917.437843404869, 5919.378465261172, 5939.168516407706, 5982.940170598238, 6756.0, 6770.322967703289, 6787.864242715118, 6842.897356539655, 6875.7937261882225, 5917.497012753878, 5937.050071988461, 6007.15899774032, 6008.429199226067, 6009.2188015557695, 5740.024195886709, 5742.08126699726, 5803.651780893076, 5811.912821307684, 5823.388544202882, 6378.075179099004, 6459.031145328238, 6487.610743355413, 6516.478681705452, 6608.107905432705, 6755.763548275787, 6764.120664313607, 6768.932310676831, 6802.14973128359, 6812.284710105368, 6521.8695626088165, 6534.379233972765, 6560.80317590454, 6570.638614876228, 6579.17760279965, 6614.503912206507, 6651.135352404156, 6735.225449073223, 6745.156855393076, 6755.527113102035, 6585.604863708193, 6662.367075127855, 6715.832104197434, 6733.865322693617, 6864.3822056013205, 6502.479801615765, 6519.706613202323, 6531.379518945692, 6532.216134063943, 6576.145101136822, 6479.643619600779, 6486.935130648633, 6566.080748695282, 6566.244881838458, 6605.47156227491, 6424.678766061772, 6434.549581529248, 6504.317046710027, 6505.284418714033, 6521.02184672303, 6416.711247993758, 6546.639934803631, 6574.934250657432, 6662.766803161866, 6679.4990375721045, 6452.322506136976, 6461.19235095613, 6471.06169605414, 6512.479001679949, 6513.446357059703], "value": 6148.100933059186, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [792.635387721648, 846.2087947768837, 859.9828003439935, 873.70294100006, 1113.3153110836827, 28872.0, 29341.853290733543, 37502.81248593757, 38486.80756596213, 38585.03537411566, 38666.8066659667, 38965.80517097418, 39074.8046259769, 39078.80460597693, 39132.41301380475, 7489.700411983514, 7729.53622782632, 7739.806504837396, 7751.147373788879, 7762.184970578092, 7413.147488038863, 7632.961835190817, 7637.656305466267, 7650.885236721454, 7652.502587331834, 7634.5037572557885, 7716.537007779523, 7743.690252389898, 7750.728724494616, 7753.2634399732215, 7566.01641786567, 7630.504017238862, 7633.618319084024, 7639.04511936008, 7662.348700360476, 7556.055493063367, 7637.847243055107, 7639.388848892076, 7641.0, 7641.3504852087635, 34605.65394346049, 34800.47799283013, 34889.302213955576, 34956.0, 35006.124846878774, 3477.1654802847133, 3506.3162683276773, 3513.7540372173958, 3515.6835884770494, 3522.6477352264824, 29430.558541621893, 29446.558301625493, 29508.0, 29522.409551809058, 29627.0, 4957.479464656195, 5113.923291150636, 5148.768305426227, 5160.174372100446, 5231.869203269949, 180719.0, 181411.0, 182128.0, 182480.0, 183403.0, 45339.77330113328, 45421.318680219825, 45593.544064559595, 45648.0, 45737.542624573325, 48184.7590762051, 48252.75873620679, 48516.27225591619, 48595.5140448591, 48814.0, 12598.307093109783, 12850.550230742067, 15439.768403473958, 15675.608109797346, 15718.528444146694, 12700.87299126997, 12923.935380323039, 12932.094753367173, 12946.093773435958, 12955.157914735511, 13549.66125846842, 13652.317384130754, 13661.726765464833, 13693.178409295475, 13734.313284335743, 5562.276904002454, 5574.1917421973585, 5647.37878833328, 5674.829755107354, 5729.942700572941, 947.8530827721714, 988.5551501824208, 991.3407583956732, 993.4536005197112, 1018.180364806338, 21855.890720546297, 21902.780972190394, 22096.668549971764, 22127.557448851254, 22333.55332893333, 1089.4171618184391, 1092.448313601626, 1095.8411030400707, 1105.8230683090828, 1107.9667609971714, 11697.590584329508, 11720.824187637192, 11744.647660570197, 11818.231814932002, 11888.465019074163, 239277.0, 239683.0, 239876.0, 240454.0, 240567.0, 53822.0, 54275.45724542704, 54285.72857135689, 54325.72837135789, 54570.0, 1472.4110355857742, 1479.0681870421565, 1480.9185494797673, 1489.0, 1490.3516970118033, 26479.867600661873, 26826.731732682423, 26945.59581606238, 26985.460290793682, 27223.0, 36253.27493450169, 36269.81865090658, 36381.63618363888, 36523.81738091292, 36746.816265918496, 202322.0, 202906.0, 202988.0, 203173.0, 204180.0, 30115.247118822204, 30528.542071868495, 30804.0, 32608.34783304273, 33700.662993369755, 39073.60926390813, 40174.0, 40211.59788402078, 40432.39351409672, 40574.0, 30311.484425779065, 30501.23746906345, 31051.068467946, 31058.0, 31067.84466077655, 29830.105096847128, 30275.24311892132, 30330.42611512584, 30365.24086897757, 30414.695853041187, 34763.304733904675, 34969.65030349664, 35012.64987350094, 35188.82405587956, 35284.117897052776, 29369.53152342417, 29767.404651906407, 29976.400471990873, 29992.250193744458, 30291.69708302977, 21974.670379943993, 22237.66643500381, 22485.32544023682, 22638.660420094042, 23631.52736945286], "value": 16691.693852024866, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [532.1963834609741, 541.5829811045497, 543.6819460615541, 545.3837164004674, 553.8283132229009, 21686.674699879495, 21979.780202197973, 22524.43688907778, 22576.322710318676, 22585.77414225857, 25224.87387563064, 25971.0, 25985.09052183174, 26130.216093517178, 26147.47705045898, 6982.720691172347, 7177.820554486154, 7178.389836863873, 7179.533330333537, 7193.568385896863, 6615.437687796543, 6967.4774391920555, 6971.721131154748, 6973.267806880255, 6980.057692211537, 6843.144606924135, 6897.068895699066, 6909.309069093076, 6916.135483064617, 6919.515633905628, 6837.247902730695, 6842.1105256316605, 6853.143357080365, 6853.7943861684225, 6857.55425897315, 6751.358620931003, 6775.932240677579, 6807.0810440590385, 6832.45340372769, 6836.4530837532875, 29393.412131757457, 30057.0, 30531.2367190822, 30594.0, 30733.538996915064, 2071.6892466130203, 2108.061912448961, 2112.524681946565, 2119.9046042928107, 2122.7028216049766, 20292.289769858133, 21043.5791284175, 21111.15555377783, 21196.940152992287, 21295.254666086614, 2523.596224604073, 2549.4646124313917, 2605.231456720272, 2627.238100950722, 2635.45973075521, 139418.0, 141466.29266853703, 143553.28223358816, 148075.0, 149140.0, 20608.58782824335, 21326.253581124587, 21542.461438464165, 21561.353159405244, 22214.66677999831, 42312.576874230865, 42343.0, 42651.36022959658, 42697.35953960693, 42974.78512607479, 11503.942480287713, 11782.82325765097, 11862.406879655982, 11869.347185904859, 12119.697007574705, 9759.99920016395, 9847.409155450696, 9998.0, 10032.749181270527, 10036.397816131055, 11207.159463040141, 11274.661760147208, 11315.886841131483, 11517.942410288062, 11833.940830295793, 3709.956147798858, 3722.683571896365, 3774.0, 4092.3656833190903, 4385.90352411897, 924.1867156901883, 962.279249859592, 962.31675510387, 971.5142428785607, 979.0307595480423, 19663.705044424347, 19788.802111978985, 20174.495637609176, 20515.4871128223, 23232.07071717146, 988.5600907596195, 1025.7999690060367, 1034.534459493231, 1043.9791204175874, 1052.0636633396284, 10821.188410869216, 11177.944110279559, 11178.329300242012, 11217.214794964275, 11394.681882226021, 549969.0, 551295.0, 551516.0, 557682.0, 567180.0, 121519.0, 122875.0, 126049.0, 126353.0, 127832.0, 1057.471264367816, 1122.859642544682, 1174.682835634374, 1223.2966044524435, 1234.5679012345786, 20354.389368318974, 20923.37229883106, 21848.672269916282, 21865.234716784835, 21968.231111911005, 56320.0, 57076.0, 57683.4231657678, 58639.4136058651, 60932.390676094445, 69506.0, 70090.64954675194, 70099.29900701132, 70151.29848701652, 70950.64524677343, 14278.42886284537, 14527.709445811235, 14573.271336433349, 14642.341094650554, 14686.779698304748, 22991.65512517347, 23011.769882301633, 23108.653370199125, 23128.76871231266, 23288.301350959497, 18149.455516334532, 18299.542511436786, 18387.908060459613, 18651.90674046621, 18806.717899231247, 16471.423500177436, 16489.91755041217, 16965.406210782563, 16998.830011699723, 17414.82585174183, 18792.812071879107, 18928.14823332926, 19128.71306930425, 19180.712289315394, 19240.518987025436, 14355.784663230268, 14480.782788258395, 14510.274486275855, 14570.34433450476, 14613.123212607277, 18316.450506484827, 18427.53931151732, 18476.630467390307, 18678.813211867706, 18723.812761872206], "value": 12927.672965003849, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1308.5616318533291, 1371.7050834070685, 1383.0802516326644, 1384.6676797568584, 1385.3350391811923, 12352.135350525466, 14386.42454301828, 15058.472953446619, 15063.849361506382, 15097.773533396994, 12374.319412432335, 14398.640033999156, 14654.85345146551, 14667.85332146681, 14790.630234244123, 2683.2621029216975, 2707.2555047361934, 2712.471068141713, 2720.088770261965, 2722.823016503931, 2589.1067581684288, 2664.2673264852224, 2667.6932152802383, 2668.7064422913463, 2668.83986960782, 2673.665791776028, 2708.0386462805714, 2711.024031348713, 2712.593111033341, 2713.74219449152, 2551.7448255174518, 2557.7825884799813, 2573.6010918307693, 2575.4720282342073, 2576.8711564421797, 2455.7789798918006, 2480.2435257246534, 2485.8135639827087, 2498.1756020513185, 2514.6228065790096, 14026.509072182527, 14082.71834563303, 14148.221847798366, 14149.717005659932, 14152.363143658456, 7472.887906681404, 7772.106207786064, 7796.688132474695, 7798.298153166185, 7807.6876924922935, 5087.694738315676, 5177.715225662587, 5243.082460569385, 5502.0921547944545, 5516.503514683657, 1942.873713208637, 1965.1942703491643, 1980.8514361422806, 1982.9405117846343, 2013.798620137989, 24921.750782492123, 25076.0, 25113.121040763668, 25116.0, 25122.12072577451, 7041.92958070423, 7157.852644206717, 7326.157491888394, 7346.77959661211, 7363.226861179606, 16444.506664800076, 16583.83416165823, 16627.168641567874, 16644.167791610373, 16704.74942875858, 7620.466567340233, 7789.532628042336, 7789.571573563395, 7791.10402303731, 7804.648790804427, 5480.588955828249, 6016.969915150396, 7163.67763450646, 7167.319104685047, 7184.712611495586, 5008.874778130576, 5186.766595503212, 5192.766325515361, 5195.19474481456, 5260.736963151904, 1390.0817665953496, 1401.9158850469005, 1402.7194561087824, 1412.2656218766183, 1416.2281556551704, 899.869518919766, 911.252772726358, 920.1120918313859, 928.2852203803034, 928.4382948316306, 7752.844943101107, 7829.804254893673, 7863.842723145505, 7895.0, 7904.249096335839, 700.0409439068509, 718.8202949262684, 721.1094298541298, 725.6045455226914, 735.3492159438935, 4867.367242258484, 4898.069366820293, 5418.485243901823, 5421.620486565981, 5504.2294078829, 20743.58512829735, 21025.15899364039, 21055.368338949855, 21109.26117585877, 21326.78673213279, 20121.39635810928, 20340.49148771263, 20698.172073116908, 21086.0, 21128.0, 10490.423026733602, 10676.83984740214, 10780.51487683056, 10827.133829293794, 10834.079103276152, 8231.0, 8341.499510029418, 8391.664333426594, 8413.411061225655, 8422.0, 17925.28298868083, 18065.187066582297, 18303.816961830213, 18435.53911152232, 18609.53476163107, 17974.730379044588, 18293.0, 18519.81480185235, 18546.979916104203, 18740.812591873906, 10653.0, 10693.51879165455, 10833.891661083288, 10861.185411094042, 10885.891141088488, 13194.538191163263, 13441.932790336377, 13442.798358024833, 13444.327783610976, 13470.52853150135, 10651.360918344924, 10719.0, 10739.570417183226, 10867.891321086689, 10953.56185752561, 10706.839397408889, 10879.945600271947, 11026.944865275944, 11099.056580190774, 11148.832767508657, 9936.403815771077, 9964.900350996397, 9992.450415226942, 10043.246756493147, 10093.343932644355, 7371.447141464304, 7422.814429639302, 7457.403407727477, 7498.062742157231, 7499.625018748931, 7547.358474529727, 7688.692452301845, 7714.5756983366455, 7741.341985931259, 7892.84214315699], "value": 6469.979909804792, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.0011155045169, 500.8622628777088, 515.466492180593, 525.2462716002539, 533.1815662957362, 6435.613863168213, 6454.419102280794, 6454.580452270605, 6512.4464420524255, 6541.869162616751, 6098.542609304309, 6163.63018218906, 6214.69491406804, 6310.148130002448, 6318.0, 5068.265101560262, 5068.5438310552045, 5089.524038028986, 5096.184610462326, 5105.234214867781, 5003.249512573107, 5042.142835717937, 5058.898822023557, 5059.215821547666, 5078.898422031557, 4863.0, 4976.104301225778, 4983.476734942833, 5026.447090820006, 5050.545450909417, 5008.54923056923, 5014.122528557488, 5027.346444962168, 5040.34475518184, 5053.797848086072, 4510.413646225969, 4517.570830771071, 4526.343680166357, 4535.299262776459, 4548.135854187693, 6210.782622608187, 6223.20812974012, 6254.593451425689, 6264.749410023594, 6280.277768056686, 5768.134779783024, 5807.1835159947395, 5809.302883653946, 5811.285670727146, 5818.738156782955, 6605.438537724299, 6634.004899265149, 6674.432673222782, 6692.196936367667, 6705.731770729165, 4900.79464241093, 4904.027737532574, 4907.533784290486, 4911.568773457162, 4913.852584422473, 7008.719651213945, 7034.402075823612, 7077.823054423629, 7085.149782026138, 7113.181984071794, 5040.798368065236, 5046.293518907356, 5056.696598204119, 5070.4929507049, 5084.3644544431945, 5098.419489958125, 5103.897922041539, 5106.285120083191, 5124.333836601292, 5134.486551344836, 5742.856428589235, 5770.16332631766, 5784.132380142928, 5801.245838041028, 5828.125781132864, 6694.297098804653, 6720.596764194164, 6737.764178253738, 6739.258681545026, 6790.49071319653, 1687.8396552327508, 1695.8982461052376, 1723.2676112652073, 1755.4733579925971, 1786.7141257398753, 1204.795184818583, 1226.3255209634665, 1226.4848763519344, 1229.956951506693, 1232.8732935686048, 5778.191053252548, 5829.854253643693, 5859.560532960045, 5879.323877754027, 5911.733971971272, 6655.866882662416, 6776.290478117661, 6794.048833163361, 6819.737663960025, 6875.5530890491955, 5870.911936320958, 5878.2358293421585, 5889.646621202742, 5897.852553686193, 5914.172015917775, 3602.4056030755155, 3605.549306336708, 3624.836882340301, 3625.148090198801, 3640.287985450856, 6612.0412540181405, 6648.404382948058, 6652.168478940132, 6657.900131498031, 6685.966570167216, 7058.0, 7077.646117694095, 7092.326229008236, 7143.24995875436, 7169.749058782918, 6511.34886511345, 6690.69891854858, 6696.732130714814, 6699.196096468455, 6736.292689267556, 6889.448844092561, 6926.229508196761, 6936.745557693871, 6947.3747362737595, 6952.617606031717, 6708.98730380874, 6791.320867913169, 6801.047853300641, 6826.965865170642, 6865.965670171618, 6608.636524991171, 6613.768518101843, 6654.700538475683, 6664.7673029535645, 6724.428423583854, 5058.418281897629, 5073.213651883964, 5076.0, 5090.618203634668, 5093.821716240062, 6810.829729256809, 6916.827079322856, 6949.339812717783, 6957.0, 6972.860542789217, 6658.866822663616, 6679.432248258952, 6717.458097069839, 6761.425278851353, 6775.1531058617675, 6549.869002619826, 6554.573952693059, 6651.401373876374, 6653.567518111307, 6660.167479065117, 6287.862126876884, 6422.935770642421, 6552.443042341454, 6555.70499327541, 6587.934120658923, 6587.948411726849, 6654.334566543307, 6659.633720145439, 6709.295523969913, 6768.763093291711, 6320.241571011508, 6326.620402775849, 6350.523710721806, 6394.424501794861, 6492.091107245084], "value": 5138.630299111182, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [872.8996165440976, 874.6982291109568, 881.982360352793, 885.5306687455651, 895.5522238880558, 18522.07389630518, 19617.705734413976, 19699.21203151872, 19723.605527889435, 20943.68584471234, 20744.48138796531, 21458.57082858346, 21523.139074437004, 21678.024488897998, 21796.237131700393, 921.1387352825113, 942.6983365323099, 942.8255772682041, 945.5697657565792, 949.178960199426, 935.8736570562955, 956.4022485946283, 965.7923546437514, 970.6554173268494, 972.4408465132577, 1014.7158795537262, 1014.7919676466307, 1015.1117771949545, 1016.7559785651428, 1017.0338178730199, 991.3902949685963, 994.7910938702809, 995.4574756757548, 998.2962011781676, 1003.6687892995294, 731.893875388071, 736.9705211791522, 737.2553720742036, 737.6016950846537, 737.6754228139602, 19300.1314940828, 19510.80489195104, 19705.0, 19746.11142498591, 20017.899910500353, 20659.793402065938, 20944.581108377748, 21435.14259429621, 21437.46406339854, 21459.463513412134, 16857.915710421494, 17066.914665426717, 17197.312107515685, 17212.053337066456, 17470.301187952467, 3716.2567486502808, 3743.5507739071486, 3745.045013521562, 3747.1006958330076, 3747.4378843173467, 126208.0, 126835.0, 127338.36330818379, 128568.35715821455, 129425.0, 16393.262303196385, 16408.83591164097, 16414.753778693328, 16760.497185084467, 17104.315827367016, 28891.855540722583, 29378.11865644034, 29439.26401839971, 29697.703022969927, 30267.0, 7747.0, 8026.478278911852, 8505.192006759347, 8850.070742572067, 9205.355625106178, 4187.267228235108, 4358.302671572533, 4378.0, 4392.670549708785, 4396.934045989313, 5086.516780905808, 5150.27896094547, 5247.396549396792, 5254.579633629377, 5289.788408463618, 1065.174489770434, 1072.3887384191091, 1089.1014912696899, 1090.3948308688755, 1091.5197313182175, 657.7927952694886, 664.7141729056456, 681.0907438569565, 690.8721886451023, 693.3794254142514, 11558.595449159238, 11844.155844155845, 12628.305443200712, 12818.359082045861, 13254.73490530184, 690.0994202565599, 690.3821080133253, 693.774523279936, 696.20632478974, 706.780897921646, 5342.5993050521365, 5382.91925621116, 5498.3127109111365, 5510.889782204334, 5512.972435137799, 110441.44779276213, 110897.0, 111904.0, 117655.41172294084, 118033.0, 97932.51033744785, 98350.0, 100486.0, 102014.0, 102047.4897625522, 84973.0, 87627.56186219028, 87853.12146878577, 88232.11767882368, 89473.0, 12785.232886026868, 12911.0, 13022.609321720363, 13024.804627930778, 13130.212187268413, 40058.0, 40661.39007914943, 40695.38956915708, 40712.796436017634, 40889.1822163561, 50793.746031269606, 52104.21843672424, 52175.73912130415, 53092.0, 53183.20225196548, 17927.10364481797, 18182.181801818686, 18218.72671909896, 18276.81723182751, 18292.542686432946, 19805.702914456007, 20028.0, 20087.598248034665, 20114.798852011878, 20249.0, 18832.24671013144, 18953.71569426432, 19016.619667606847, 19239.903800480908, 19244.23023079117, 17281.913590431966, 17434.21546030406, 17549.034803085953, 17735.733963990293, 17793.288268469118, 17562.29750809953, 17692.469225923243, 17702.734458982868, 17796.91101544536, 17887.37394191197, 13891.235982021086, 14040.244969378828, 14089.788653170415, 14126.858731412554, 14473.276336182938, 13563.186208827501, 13629.727405452033, 13630.795538067136, 13756.17462952186, 14015.929920350332], "value": 9090.0719221782, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1514.0999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 110.0, 102.0, 107.0, 107.0, 112.0, 111.0, 99.0, 107.0, 110.0], "value": 106.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 118.0, 146.0, 169.0, 118.0, 140.0, 149.0, 126.0, 174.0, 119.0], "value": 140.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 164.0, 164.0, 162.0, 163.0, 162.0, 171.0, 165.0, 166.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 74.0, 74.0, 170.0, 75.0, 76.0, 81.0, 75.0, 166.0, 75.0], "value": 94.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 134.0, 80.0, 80.0, 79.0, 131.0, 80.0, 79.0, 130.0], "value": 95.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 115.0, 114.0, 115.0, 116.0, 116.0, 114.0, 114.0], "value": 114.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 150.0, 148.0, 150.0, 149.0, 148.0, 150.0, 148.0, 149.0, 148.0], "value": 149.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 52.0, 53.0, 52.0, 52.0, 52.0, 53.0, 52.0, 52.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 56.0, 55.0, 55.0, 56.0, 55.0, 55.0, 56.0, 56.0], "value": 55.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 81.0, 75.0, 86.0, 80.0, 74.0, 75.0, 75.0, 76.0, 81.0], "value": 77.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 121.0, 119.0, 123.0, 135.0, 128.0, 118.0, 116.0, 124.0, 164.0], "value": 127.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 170.0, 176.0, 177.0, 174.0, 173.0, 179.0, 172.0, 178.0, 184.0], "value": 176.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 65.0, 63.0, 65.0, 64.0, 62.0, 64.0, 69.0], "value": 64.9, "unit": "score"}]}]} 05:35:48 INFO - Return code: 0 05:35:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:35:48 INFO - # TBPL SUCCESS # 05:35:48 INFO - Running post-action listener: _package_coverage_data 05:35:48 INFO - Running post-action listener: _resource_record_post_action 05:35:48 INFO - [mozharness: 2017-08-24 12:35:48.722584Z] Finished run-tests step (success) 05:35:48 INFO - Running post-run listener: _resource_record_post_run 05:35:48 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 444346368; Read time: 12; Write time: 404712 05:35:48 INFO - TinderboxPrint: CPU usage
13.1% 05:35:48 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 05:35:48 INFO - TinderboxPrint: I/O write bytes / time
444,346,368 / 404,712 05:35:48 INFO - TinderboxPrint: CPU idle
8,244.1 (86.8%) 05:35:48 INFO - TinderboxPrint: CPU user
1,198.2 (12.6%) 05:35:48 INFO - TinderboxPrint: Swap in / out
0 / 0 05:35:48 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 119185408; Read time: 0; Write time: 128508 05:35:48 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:35:48 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 323723264; Read time: 0; Write time: 276144 05:35:49 INFO - Running post-run listener: _upload_blobber_files 05:35:49 INFO - Blob upload gear active. 05:35:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:35:49 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:35:49 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'] 05:35:49 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 05:35:49 INFO - (blobuploader) - INFO - Open directory for files ... 05:35:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:35:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:35:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:35:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:35:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:35:50 INFO - (blobuploader) - INFO - Done attempting. 05:35:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:35:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:35:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:35:51 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:35:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:35:51 INFO - (blobuploader) - INFO - Done attempting. 05:35:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:35:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:35:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:35:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:35:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:35:58 INFO - (blobuploader) - INFO - Done attempting. 05:35:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:35:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:35:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:35:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:35:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:35:59 INFO - (blobuploader) - INFO - Done attempting. 05:35:59 INFO - (blobuploader) - INFO - Iteration through files over. 05:35:59 INFO - Return code: 0 05:35:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:35:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:35:59 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d71cff62067f8791eb512d761a4247ed0847769d83d18dc378dc5d5178073b4de86399eb2853f2c3dedb6e152ff52fd6b7946e0749fd49308bfc3195a187a06f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6ecfde7049629bc8b6e76ab583bfae60e9a416d93069434d7df25573561f0c9aaf264a4dbd1c914096bc18716dd3fdf3acae4a815bfb41184d92f2edf05c29b6", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2cb422091de2c124abcfa5cdfcd5c33c07ba9933ed6ae1639b753fbe62da3e5eed3e28e52df500a8eb1ccff91ad18ee0eb7acf13e433a10b6536d83c3174d7af", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4ea493d6e6f508d22866b3bd4313fc5fcda3c94a8563f8a2307287d6767a0cb44f1d6d9ed53d149d793391218f318e0741481f49a71900c95a036b9b392cf3a2"} 05:35:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:35:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:35:59 INFO - Contents: 05:35:59 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d71cff62067f8791eb512d761a4247ed0847769d83d18dc378dc5d5178073b4de86399eb2853f2c3dedb6e152ff52fd6b7946e0749fd49308bfc3195a187a06f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6ecfde7049629bc8b6e76ab583bfae60e9a416d93069434d7df25573561f0c9aaf264a4dbd1c914096bc18716dd3fdf3acae4a815bfb41184d92f2edf05c29b6", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2cb422091de2c124abcfa5cdfcd5c33c07ba9933ed6ae1639b753fbe62da3e5eed3e28e52df500a8eb1ccff91ad18ee0eb7acf13e433a10b6536d83c3174d7af", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4ea493d6e6f508d22866b3bd4313fc5fcda3c94a8563f8a2307287d6767a0cb44f1d6d9ed53d149d793391218f318e0741481f49a71900c95a036b9b392cf3a2"} 05:35:59 INFO - Running post-run listener: copy_logs_to_upload_dir 05:35:59 INFO - Copying logs to upload dir... 05:35:59 INFO - mkdir: /builds/slave/test/build/upload/logs 05:35:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.906746 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-08-24 05:35:59.563850) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-24 05:35:59.567516) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1503576859.425032-237178224 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d71cff62067f8791eb512d761a4247ed0847769d83d18dc378dc5d5178073b4de86399eb2853f2c3dedb6e152ff52fd6b7946e0749fd49308bfc3195a187a06f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6ecfde7049629bc8b6e76ab583bfae60e9a416d93069434d7df25573561f0c9aaf264a4dbd1c914096bc18716dd3fdf3acae4a815bfb41184d92f2edf05c29b6", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2cb422091de2c124abcfa5cdfcd5c33c07ba9933ed6ae1639b753fbe62da3e5eed3e28e52df500a8eb1ccff91ad18ee0eb7acf13e433a10b6536d83c3174d7af", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4ea493d6e6f508d22866b3bd4313fc5fcda3c94a8563f8a2307287d6767a0cb44f1d6d9ed53d149d793391218f318e0741481f49a71900c95a036b9b392cf3a2"} build_url:https://queue.taskcluster.net/v1/task/MFQIylfTTO67nd9VpmjjPg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011241 build_url: 'https://queue.taskcluster.net/v1/task/MFQIylfTTO67nd9VpmjjPg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d71cff62067f8791eb512d761a4247ed0847769d83d18dc378dc5d5178073b4de86399eb2853f2c3dedb6e152ff52fd6b7946e0749fd49308bfc3195a187a06f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6ecfde7049629bc8b6e76ab583bfae60e9a416d93069434d7df25573561f0c9aaf264a4dbd1c914096bc18716dd3fdf3acae4a815bfb41184d92f2edf05c29b6", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2cb422091de2c124abcfa5cdfcd5c33c07ba9933ed6ae1639b753fbe62da3e5eed3e28e52df500a8eb1ccff91ad18ee0eb7acf13e433a10b6536d83c3174d7af", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4ea493d6e6f508d22866b3bd4313fc5fcda3c94a8563f8a2307287d6767a0cb44f1d6d9ed53d149d793391218f318e0741481f49a71900c95a036b9b392cf3a2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-24 05:35:59.600195) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 05:35:59.600711) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1503576859.425032-237178224 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004513 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 05:35:59.679629) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-24 05:35:59.679932) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-24 05:35:59.680390) ========= ========= Total master_lag: 0.17 =========