builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-020 starttime: 1504824149.69 results: success (0) revision: 64bf417d1bdf9bb8b562d73cc0742b1ec60a8d0e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-07 15:42:29.688403) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-07 15:42:29.689051) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-07 15:42:29.689361) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-07 15:42:29.705332) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 15:42:29.705648) ========= 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=af724c981e2a0f424dbabf99000001e7-1504824148.52930-1787114130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-07 15:42:29-- 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% 35.1M=0s 2017-09-07 15:42:30 (35.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.372149 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 15:42:30.097889) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 15:42:30.098303) ========= 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=af724c981e2a0f424dbabf99000001e7-1504824148.52930-1787114130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022867 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 15:42:30.148357) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 15:42:30.148723) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 64bf417d1bdf9bb8b562d73cc0742b1ec60a8d0e --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 64bf417d1bdf9bb8b562d73cc0742b1ec60a8d0e --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=af724c981e2a0f424dbabf99000001e7-1504824148.52930-1787114130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-07 15:42:30,197 truncating revision to first 12 chars 2017-09-07 15:42:30,197 Setting DEBUG logging. 2017-09-07 15:42:30,197 attempt 1/10 2017-09-07 15:42:30,197 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/64bf417d1bdf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-07 15:42:30,552 unpacking tar archive at: mozilla-central-64bf417d1bdf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.633405 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 15:42:30.804739) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-07 15:42:30.805052) ========= script_repo_revision: 64bf417d1bdf9bb8b562d73cc0742b1ec60a8d0e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-07 15:42:30.805517) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-07 15:42:30.805820) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-07 15:42:30.819612) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-09-07 15:42:30.819994) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-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-stylo-disabled-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=af724c981e2a0f424dbabf99000001e7-1504824148.52930-1787114130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:42:30 INFO - MultiFileLogger online at 20170907 15:42:30 in /builds/slave/test 15:42:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-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 15:42:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:42:30 INFO - {'append_to_log': False, 15:42:30 INFO - 'base_work_dir': '/builds/slave/test', 15:42:30 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:42:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:42:30 INFO - 'branch': 'Firefox-Non-PGO', 15:42:30 INFO - 'buildbot_json_path': 'buildprops.json', 15:42:30 INFO - 'code_coverage': False, 15:42:30 INFO - 'config_files': ('talos/linux_config.py',), 15:42:30 INFO - 'default_actions': ('clobber', 15:42:30 INFO - 'read-buildbot-config', 15:42:30 INFO - 'download-and-extract', 15:42:30 INFO - 'populate-webroot', 15:42:30 INFO - 'create-virtualenv', 15:42:30 INFO - 'install', 15:42:31 INFO - 'setup-mitmproxy', 15:42:31 INFO - 'run-tests'), 15:42:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:42:31 INFO - 'disable_ccov_upload': False, 15:42:31 INFO - 'disable_stylo': False, 15:42:31 INFO - 'download_minidump_stackwalk': True, 15:42:31 INFO - 'download_symbols': 'ondemand', 15:42:31 INFO - 'enable_stylo': False, 15:42:31 INFO - 'enable_webrender': False, 15:42:31 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:42:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:42:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:42:31 INFO - 'gecko_profile': False, 15:42:31 INFO - 'gecko_profile_interval': 0, 15:42:31 INFO - 'installer_path': 'installer.exe', 15:42:31 INFO - 'log_level': 'info', 15:42:31 INFO - 'log_name': 'talos', 15:42:31 INFO - 'log_to_console': True, 15:42:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:42:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:42:31 INFO - 'opt_config_files': (), 15:42:31 INFO - 'pip_index': False, 15:42:31 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 15:42:31 INFO - 'system_bits': '32', 15:42:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:42:31 INFO - 'title': 'talos-linux64-ix-020', 15:42:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:42:31 INFO - 'use_talos_json': True, 15:42:31 INFO - 'verify': 'False', 15:42:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:42:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:42:31 INFO - 'work_dir': 'build'} 15:42:31 INFO - [mozharness: 2017-09-07 22:42:31.005433Z] Running clobber step. 15:42:31 INFO - Running pre-action listener: _resource_record_pre_action 15:42:31 INFO - Running main action method: clobber 15:42:31 INFO - rmtree: /builds/slave/test/build 15:42:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:42:32 INFO - Running post-action listener: _resource_record_post_action 15:42:32 INFO - [mozharness: 2017-09-07 22:42:32.555028Z] Finished clobber step (success) 15:42:32 INFO - [mozharness: 2017-09-07 22:42:32.555125Z] Running read-buildbot-config step. 15:42:32 INFO - Running pre-action listener: _resource_record_pre_action 15:42:32 INFO - Running main action method: read_buildbot_config 15:42:32 INFO - Using buildbot properties: 15:42:32 INFO - { 15:42:32 INFO - "project": "", 15:42:32 INFO - "product": "firefox", 15:42:32 INFO - "who": "archaeopteryx@coole-files.de", 15:42:32 INFO - "installer_path": "public/build/target.tar.bz2", 15:42:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 15:42:32 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:42:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 15:42:32 INFO - "stage_platform": "linux64", 15:42:32 INFO - "basedir": "/builds/slave/test", 15:42:32 INFO - "buildnumber": 2, 15:42:32 INFO - "platform": "ubuntu64_hw", 15:42:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:42:32 INFO - "slavebuilddir": "test", 15:42:32 INFO - "taskId": "KsB8pe1bTmuY8NW9RK5JPA", 15:42:32 INFO - "branch": "mozilla-central", 15:42:32 INFO - "script_repo_revision": "production", 15:42:32 INFO - "revision": "64bf417d1bdf9bb8b562d73cc0742b1ec60a8d0e", 15:42:32 INFO - "slavename": "talos-linux64-ix-020", 15:42:32 INFO - "repo_path": "mozilla-central" 15:42:32 INFO - } 15:42:32 INFO - Finding installer, test and symbols from parent task. 15:42:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KsB8pe1bTmuY8NW9RK5JPA'}, attempt #1 15:42:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KsB8pe1bTmuY8NW9RK5JPA'}, attempt #1 15:42:33 INFO - Task dependencies: HU_acp97TAesHcVo7pnBow 15:42:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow'}, attempt #1 15:42:33 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.tar.bz2 15:42:33 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.test_packages.json 15:42:33 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.crashreporter-symbols.zip 15:42:33 INFO - Running post-action listener: _resource_record_post_action 15:42:33 INFO - [mozharness: 2017-09-07 22:42:33.886871Z] Finished read-buildbot-config step (success) 15:42:33 INFO - [mozharness: 2017-09-07 22:42:33.887089Z] Running download-and-extract step. 15:42:33 INFO - Running pre-action listener: _resource_record_pre_action 15:42:33 INFO - Running main action method: download_and_extract 15:42:33 INFO - mkdir: /builds/slave/test/build/tests 15:42:33 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')]} 15:42:33 INFO - trying https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.test_packages.json 15:42:33 INFO - Downloading https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:42:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:42:34 INFO - Downloaded 989 bytes. 15:42:34 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:42:34 INFO - Using the following test package requirements: 15:42:34 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:42:34 INFO - u'common': [u'target.common.tests.zip'], 15:42:34 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:42:34 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:42:34 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:42:34 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:42:34 INFO - u'mozbase': [u'target.common.tests.zip'], 15:42:34 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:42:34 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:42:34 INFO - u'web-platform': [u'target.common.tests.zip', 15:42:34 INFO - u'target.web-platform.tests.tar.gz'], 15:42:34 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:42:34 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 15:42:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.common.tests.zip 15:42:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:42:34 INFO - Fetch https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.common.tests.zip into memory 15:42:35 INFO - Content-Length response header: 55021152 15:42:35 INFO - Bytes received: 55021152 15:42:47 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 15:42:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.common.tests.zip 15:42:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:42:47 INFO - Fetch https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.common.tests.zip into memory 15:42:48 INFO - Content-Length response header: 55021152 15:42:48 INFO - Bytes received: 55021152 15:43:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.talos.tests.zip 15:43:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:43:00 INFO - Fetch https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.talos.tests.zip into memory 15:43:01 INFO - Content-Length response header: 14496665 15:43:01 INFO - Bytes received: 14496665 15:43:03 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')]} 15:43:03 INFO - trying https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.tar.bz2 15:43:03 INFO - Downloading https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:43:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:43:04 INFO - Downloaded 62707151 bytes. 15:43:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.tar.bz2 15:43:04 INFO - mkdir: /builds/slave/test/properties 15:43:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:43:04 INFO - Writing to file /builds/slave/test/properties/build_url 15:43:04 INFO - Contents: 15:43:04 INFO - build_url:https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.tar.bz2 15:43:04 INFO - Running post-action listener: _resource_record_post_action 15:43:04 INFO - Running post-action listener: find_tests_for_verification 15:43:04 INFO - Running post-action listener: set_extra_try_arguments 15:43:04 INFO - [mozharness: 2017-09-07 22:43:04.146271Z] Finished download-and-extract step (success) 15:43:04 INFO - [mozharness: 2017-09-07 22:43:04.146367Z] Running populate-webroot step. 15:43:04 INFO - Running pre-action listener: _resource_record_pre_action 15:43:04 INFO - Running main action method: populate_webroot 15:43:04 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:43:04 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:43:04 INFO - 'tests': ['tresize', 15:43:04 INFO - 'tcanvasmark']}, 15:43:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:43:04 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:43:04 INFO - 'tests': ['dromaeo_css', 15:43:04 INFO - 'kraken']}, 15:43:04 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:43:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:43:04 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:43:04 INFO - 'talos_options': ['--disable-stylo'], 15:43:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:43:04 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:43:04 INFO - 'tests': ['damp', 'tps']}, 15:43:04 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:43:04 INFO - 'talos_options': ['--disable-stylo'], 15:43:04 INFO - 'tests': ['damp', 'tps']}, 15:43:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:43:04 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:43:04 INFO - 'tests': ['dromaeo_dom']}, 15:43:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:43:04 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:43:04 INFO - 'tests': ['basic_compositor_video', 15:43:04 INFO - 'glvideo']}, 15:43:04 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:43:04 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:43:04 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:43:04 INFO - 'talos_options': ['--disable-stylo'], 15:43:04 INFO - 'tests': ['ts_paint_webext', 15:43:04 INFO - 'tp5o_webext']}, 15:43:04 INFO - 'other-e10s': {'tests': ['a11yr', 15:43:04 INFO - 'ts_paint', 15:43:04 INFO - 'tpaint', 15:43:04 INFO - 'sessionrestore', 15:43:04 INFO - 'sessionrestore_many_windows', 15:43:04 INFO - 'sessionrestore_no_auto_restore', 15:43:04 INFO - 'tabpaint']}, 15:43:04 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:43:04 INFO - 'tests': ['a11yr', 15:43:04 INFO - 'ts_paint', 15:43:04 INFO - 'tpaint', 15:43:04 INFO - 'sessionrestore', 15:43:04 INFO - 'sessionrestore_many_windows', 15:43:04 INFO - 'sessionrestore_no_auto_restore', 15:43:04 INFO - 'tabpaint']}, 15:43:04 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:43:04 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 15:43:04 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:43:04 INFO - 'tests': ['bloom_basic_singleton']}, 15:43:04 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:43:04 INFO - 'tests': ['bloom_basic']}, 15:43:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:43:04 INFO - 'tsvgr_opacity', 15:43:04 INFO - 'tart', 15:43:04 INFO - 'tscrollx', 15:43:04 INFO - 'tsvg_static']}, 15:43:04 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:43:04 INFO - 'tests': ['tsvgx', 15:43:04 INFO - 'tsvgr_opacity', 15:43:04 INFO - 'tart', 15:43:04 INFO - 'tscrollx', 15:43:04 INFO - 'tsvg_static']}, 15:43:04 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:43:04 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:43:04 INFO - 'talos_options': ['--disable-stylo'], 15:43:04 INFO - 'tests': ['tp5o']}, 15:43:04 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:43:04 INFO - 'talos_options': ['--mitmproxy', 15:43:04 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:43:04 INFO - '--firstNonBlankPaint'], 15:43:04 INFO - 'tests': ['tp6_google', 15:43:04 INFO - 'tp6_youtube', 15:43:04 INFO - 'tp6_amazon', 15:43:04 INFO - 'tp6_facebook']}, 15:43:04 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:43:04 INFO - 'talos_options': ['--disable-stylo', 15:43:04 INFO - '--mitmproxy', 15:43:04 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:43:04 INFO - '--firstNonBlankPaint'], 15:43:04 INFO - 'tests': ['tp6_google', 15:43:04 INFO - 'tp6_youtube', 15:43:04 INFO - 'tp6_amazon', 15:43:04 INFO - 'tp6_facebook']}, 15:43:04 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:43:04 INFO - 'talos_options': ['--stylo-threads=1', 15:43:04 INFO - '--mitmproxy', 15:43:04 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:43:04 INFO - '--firstNonBlankPaint'], 15:43:04 INFO - 'tests': ['tp6_google', 15:43:04 INFO - 'tp6_youtube', 15:43:04 INFO - 'tp6_amazon', 15:43:04 INFO - 'tp6_facebook']}, 15:43:04 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:43:04 INFO - 'talos_options': ['--xperf_path', 15:43:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:43:04 INFO - 'tests': ['tp5n']}, 15:43:04 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:43:04 INFO - 'talos_options': ['--disable-stylo', 15:43:04 INFO - '--xperf_path', 15:43:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:43:04 INFO - 'tests': ['tp5n']}}} 15:43:04 INFO - Running post-action listener: _resource_record_post_action 15:43:04 INFO - [mozharness: 2017-09-07 22:43:04.161485Z] Finished populate-webroot step (success) 15:43:04 INFO - [mozharness: 2017-09-07 22:43:04.161574Z] Running create-virtualenv step. 15:43:04 INFO - Running pre-action listener: _resource_record_pre_action 15:43:04 INFO - Running main action method: create_virtualenv 15:43:04 INFO - Creating virtualenv /builds/slave/test/build/venv 15:43:04 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:43:04 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:43:04 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:43:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:43:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:43:04 INFO - Installing distribute.............................................................................................................................................................................................done. 15:43:05 INFO - Installing pip...............done. 15:43:05 INFO - Return code: 0 15:43:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:43:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:43:05 INFO - Reading from file tmpfile_stdout 15:43:05 INFO - Output received: 15:43:05 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 15:43:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:43:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:05 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 0x1f2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229f090>, '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 0x229fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2299f90>, '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': 'af724c981e2a0f424dbabf99000001e7-1504824148.52930-1787114130', '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 15:43:05 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 15:43:05 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 15:43:05 INFO - Using env: {'DISPLAY': ':0', 15:43:05 INFO - 'HOME': '/home/cltbld', 15:43:05 INFO - 'LANG': 'en_US.UTF-8', 15:43:05 INFO - 'LANGUAGE': 'en_US:en', 15:43:05 INFO - 'LOGNAME': 'cltbld', 15:43:05 INFO - 'MAIL': '/var/mail/cltbld', 15:43:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:05 INFO - 'MOZ_NO_REMOTE': '1', 15:43:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:43:05 INFO - 'NO_EM_RESTART': '1', 15:43:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:43:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:05 INFO - 'PWD': '/builds/slave/test', 15:43:05 INFO - 'SHELL': '/bin/bash', 15:43:05 INFO - 'SHLVL': '1', 15:43:05 INFO - 'TERM': 'linux', 15:43:05 INFO - 'TMOUT': '86400', 15:43:05 INFO - 'USER': 'cltbld', 15:43:05 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1504824148.52930-1787114130', 15:43:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:05 INFO - '_': '/tools/buildbot/bin/python'} 15:43:06 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:43:06 INFO - Downloading/unpacking pip>=1.5 15:43:06 INFO - Running setup.py egg_info for package pip 15:43:06 INFO - warning: no files found matching 'pip/cacert.pem' 15:43:06 INFO - warning: no files found matching '*.html' under directory 'docs' 15:43:06 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:43:06 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:43:06 INFO - Installing collected packages: pip 15:43:06 INFO - Found existing installation: pip 1.1 15:43:06 INFO - Uninstalling pip: 15:43:06 INFO - Successfully uninstalled pip 15:43:06 INFO - Running setup.py install for pip 15:43:06 INFO - warning: no files found matching 'pip/cacert.pem' 15:43:06 INFO - warning: no files found matching '*.html' under directory 'docs' 15:43:06 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:43:06 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:43:06 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:43:06 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:43:06 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:43:06 INFO - Successfully installed pip 15:43:06 INFO - Cleaning up... 15:43:06 INFO - Return code: 0 15:43:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:43:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1f2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229f090>, '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 0x229fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2299f90>, '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': 'af724c981e2a0f424dbabf99000001e7-1504824148.52930-1787114130', '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 15:43:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:43:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:43:06 INFO - Using env: {'DISPLAY': ':0', 15:43:06 INFO - 'HOME': '/home/cltbld', 15:43:06 INFO - 'LANG': 'en_US.UTF-8', 15:43:06 INFO - 'LANGUAGE': 'en_US:en', 15:43:06 INFO - 'LOGNAME': 'cltbld', 15:43:06 INFO - 'MAIL': '/var/mail/cltbld', 15:43:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:06 INFO - 'MOZ_NO_REMOTE': '1', 15:43:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:43:06 INFO - 'NO_EM_RESTART': '1', 15:43:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:43:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:06 INFO - 'PWD': '/builds/slave/test', 15:43:06 INFO - 'SHELL': '/bin/bash', 15:43:06 INFO - 'SHLVL': '1', 15:43:06 INFO - 'TERM': 'linux', 15:43:06 INFO - 'TMOUT': '86400', 15:43:06 INFO - 'USER': 'cltbld', 15:43:06 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1504824148.52930-1787114130', 15:43:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:06 INFO - '_': '/tools/buildbot/bin/python'} 15:43:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:06 INFO - Downloading/unpacking psutil>=3.1.1 15:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:43:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:43:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:43:07 INFO - Installing collected packages: psutil 15:43:07 INFO - Running setup.py install for psutil 15:43:07 INFO - building 'psutil._psutil_linux' extension 15:43:07 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 15:43:08 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 15:43:08 INFO - building 'psutil._psutil_posix' extension 15:43:08 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 15:43:08 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 15:43:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:43:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:43:08 INFO - Successfully installed psutil 15:43:08 INFO - Cleaning up... 15:43:08 INFO - Return code: 0 15:43:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:43:08 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')]} 15:43:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:08 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')]} 15:43:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:08 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 0x1f2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229f090>, '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 0x229fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2299f90>, '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': 'af724c981e2a0f424dbabf99000001e7-1504824148.52930-1787114130', '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 15:43:08 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 15:43:08 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 15:43:08 INFO - Using env: {'DISPLAY': ':0', 15:43:08 INFO - 'HOME': '/home/cltbld', 15:43:08 INFO - 'LANG': 'en_US.UTF-8', 15:43:08 INFO - 'LANGUAGE': 'en_US:en', 15:43:08 INFO - 'LOGNAME': 'cltbld', 15:43:08 INFO - 'MAIL': '/var/mail/cltbld', 15:43:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:08 INFO - 'MOZ_NO_REMOTE': '1', 15:43:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:43:08 INFO - 'NO_EM_RESTART': '1', 15:43:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:43:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:08 INFO - 'PWD': '/builds/slave/test', 15:43:08 INFO - 'SHELL': '/bin/bash', 15:43:08 INFO - 'SHLVL': '1', 15:43:08 INFO - 'TERM': 'linux', 15:43:08 INFO - 'TMOUT': '86400', 15:43:08 INFO - 'USER': 'cltbld', 15:43:08 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1504824148.52930-1787114130', 15:43:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:08 INFO - '_': '/tools/buildbot/bin/python'} 15:43:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:43:08 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 15:43:08 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 15:43:08 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 15:43:08 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 15:43:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:43:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:43:09 INFO - Installing collected packages: mozsystemmonitor 15:43:09 INFO - Running setup.py install for mozsystemmonitor 15:43:09 INFO - Successfully installed mozsystemmonitor 15:43:09 INFO - Cleaning up... 15:43:09 INFO - Return code: 0 15:43:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:43:09 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')]} 15:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:09 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')]} 15:43:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:09 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 0x1f2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229f090>, '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 0x229fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2299f90>, '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': 'af724c981e2a0f424dbabf99000001e7-1504824148.52930-1787114130', '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 15:43:09 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 15:43:09 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 15:43:09 INFO - Using env: {'DISPLAY': ':0', 15:43:09 INFO - 'HOME': '/home/cltbld', 15:43:09 INFO - 'LANG': 'en_US.UTF-8', 15:43:09 INFO - 'LANGUAGE': 'en_US:en', 15:43:09 INFO - 'LOGNAME': 'cltbld', 15:43:09 INFO - 'MAIL': '/var/mail/cltbld', 15:43:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:09 INFO - 'MOZ_NO_REMOTE': '1', 15:43:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:43:09 INFO - 'NO_EM_RESTART': '1', 15:43:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:43:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:09 INFO - 'PWD': '/builds/slave/test', 15:43:09 INFO - 'SHELL': '/bin/bash', 15:43:09 INFO - 'SHLVL': '1', 15:43:09 INFO - 'TERM': 'linux', 15:43:09 INFO - 'TMOUT': '86400', 15:43:09 INFO - 'USER': 'cltbld', 15:43:09 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1504824148.52930-1787114130', 15:43:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:09 INFO - '_': '/tools/buildbot/bin/python'} 15:43:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:10 INFO - Downloading/unpacking jsonschema==2.5.1 15:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:43:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:11 INFO - Downloading functools32-3.2.3-2.tar.gz 15:43:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:43:11 INFO - warning: no files found matching '*.txt' 15:43:11 INFO - no previously-included directories found matching 'build' 15:43:11 INFO - no previously-included directories found matching 'dist' 15:43:11 INFO - no previously-included directories found matching '.git*' 15:43:11 INFO - Installing collected packages: jsonschema, functools32 15:43:11 INFO - Running setup.py install for functools32 15:43:11 INFO - warning: no files found matching '*.txt' 15:43:11 INFO - no previously-included directories found matching 'build' 15:43:11 INFO - no previously-included directories found matching 'dist' 15:43:11 INFO - no previously-included directories found matching '.git*' 15:43:11 INFO - Successfully installed jsonschema functools32 15:43:11 INFO - Cleaning up... 15:43:11 INFO - Return code: 0 15:43:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:43:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1f2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229f090>, '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 0x229fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2299f90>, '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': 'af724c981e2a0f424dbabf99000001e7-1504824148.52930-1787114130', '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 15:43:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:43:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:43:11 INFO - Using env: {'DISPLAY': ':0', 15:43:11 INFO - 'HOME': '/home/cltbld', 15:43:11 INFO - 'LANG': 'en_US.UTF-8', 15:43:11 INFO - 'LANGUAGE': 'en_US:en', 15:43:11 INFO - 'LOGNAME': 'cltbld', 15:43:11 INFO - 'MAIL': '/var/mail/cltbld', 15:43:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:11 INFO - 'MOZ_NO_REMOTE': '1', 15:43:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:43:11 INFO - 'NO_EM_RESTART': '1', 15:43:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:43:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:11 INFO - 'PWD': '/builds/slave/test', 15:43:11 INFO - 'SHELL': '/bin/bash', 15:43:11 INFO - 'SHLVL': '1', 15:43:11 INFO - 'TERM': 'linux', 15:43:11 INFO - 'TMOUT': '86400', 15:43:11 INFO - 'USER': 'cltbld', 15:43:11 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1504824148.52930-1787114130', 15:43:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:11 INFO - '_': '/tools/buildbot/bin/python'} 15:43:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:43:11 INFO - Cleaning up... 15:43:11 INFO - Return code: 0 15:43:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:43:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1f2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229f090>, '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 0x229fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2299f90>, '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': 'af724c981e2a0f424dbabf99000001e7-1504824148.52930-1787114130', '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 15:43:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:43:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:43:11 INFO - Using env: {'DISPLAY': ':0', 15:43:11 INFO - 'HOME': '/home/cltbld', 15:43:11 INFO - 'LANG': 'en_US.UTF-8', 15:43:11 INFO - 'LANGUAGE': 'en_US:en', 15:43:11 INFO - 'LOGNAME': 'cltbld', 15:43:11 INFO - 'MAIL': '/var/mail/cltbld', 15:43:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:11 INFO - 'MOZ_NO_REMOTE': '1', 15:43:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:43:11 INFO - 'NO_EM_RESTART': '1', 15:43:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:43:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:11 INFO - 'PWD': '/builds/slave/test', 15:43:11 INFO - 'SHELL': '/bin/bash', 15:43:11 INFO - 'SHLVL': '1', 15:43:11 INFO - 'TERM': 'linux', 15:43:11 INFO - 'TMOUT': '86400', 15:43:11 INFO - 'USER': 'cltbld', 15:43:11 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1504824148.52930-1787114130', 15:43:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:11 INFO - '_': '/tools/buildbot/bin/python'} 15:43:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:11 INFO - Downloading/unpacking blobuploader==1.2.4 15:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:13 INFO - Downloading blobuploader-1.2.4.tar.gz 15:43:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:43:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:43:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:13 INFO - Downloading docopt-0.6.1.tar.gz 15:43:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:43:13 INFO - Installing collected packages: blobuploader, requests, docopt 15:43:13 INFO - Running setup.py install for blobuploader 15:43:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:43:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:43:13 INFO - Running setup.py install for requests 15:43:14 INFO - Running setup.py install for docopt 15:43:14 INFO - Successfully installed blobuploader requests docopt 15:43:14 INFO - Cleaning up... 15:43:14 INFO - Return code: 0 15:43:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:43:14 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')]} 15:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:14 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')]} 15:43:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:14 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 0x1f2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229f090>, '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 0x229fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2299f90>, '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': 'af724c981e2a0f424dbabf99000001e7-1504824148.52930-1787114130', '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 15:43:14 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 15:43:14 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 15:43:14 INFO - Using env: {'DISPLAY': ':0', 15:43:14 INFO - 'HOME': '/home/cltbld', 15:43:14 INFO - 'LANG': 'en_US.UTF-8', 15:43:14 INFO - 'LANGUAGE': 'en_US:en', 15:43:14 INFO - 'LOGNAME': 'cltbld', 15:43:14 INFO - 'MAIL': '/var/mail/cltbld', 15:43:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:14 INFO - 'MOZ_NO_REMOTE': '1', 15:43:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:43:14 INFO - 'NO_EM_RESTART': '1', 15:43:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:43:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:14 INFO - 'PWD': '/builds/slave/test', 15:43:14 INFO - 'SHELL': '/bin/bash', 15:43:14 INFO - 'SHLVL': '1', 15:43:14 INFO - 'TERM': 'linux', 15:43:14 INFO - 'TMOUT': '86400', 15:43:14 INFO - 'USER': 'cltbld', 15:43:14 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1504824148.52930-1787114130', 15:43:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:14 INFO - '_': '/tools/buildbot/bin/python'} 15:43:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:43:14 INFO - Running setup.py (path:/tmp/pip-r4W5yM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:43:14 INFO - Running setup.py (path:/tmp/pip-5qNmKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:43:14 INFO - Running setup.py (path:/tmp/pip-WmxN26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:43:14 INFO - Running setup.py (path:/tmp/pip-uvaCpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:43:14 INFO - Running setup.py (path:/tmp/pip-u8nQFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:43:14 INFO - Running setup.py (path:/tmp/pip-Jikhp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:43:14 INFO - Running setup.py (path:/tmp/pip-H4TbDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:43:14 INFO - Running setup.py (path:/tmp/pip-fevedo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:43:15 INFO - Running setup.py (path:/tmp/pip-jwgtZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:43:15 INFO - Running setup.py (path:/tmp/pip-_w6D4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:43:15 INFO - Running setup.py (path:/tmp/pip-JbhoeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:43:15 INFO - Running setup.py (path:/tmp/pip-FmBX7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:43:15 INFO - Running setup.py (path:/tmp/pip-kRZRf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:43:15 INFO - Running setup.py (path:/tmp/pip-QhfVoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:43:15 INFO - Running setup.py (path:/tmp/pip-w8JsbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:43:15 INFO - Running setup.py (path:/tmp/pip-Gsw5Lv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:43:15 INFO - Running setup.py (path:/tmp/pip-WJ8fMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:43:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:43:15 INFO - Running setup.py install for manifestparser 15:43:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:43:15 INFO - Running setup.py install for mozcrash 15:43:15 INFO - Running setup.py install for mozdebug 15:43:15 INFO - Running setup.py install for mozdevice 15:43:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:43:16 INFO - Running setup.py install for mozfile 15:43:16 INFO - Running setup.py install for mozhttpd 15:43:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:43:16 INFO - Running setup.py install for mozinfo 15:43:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:43:16 INFO - Running setup.py install for mozInstall 15:43:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:43:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:43:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:43:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:43:16 INFO - Running setup.py install for mozleak 15:43:16 INFO - Running setup.py install for mozlog 15:43:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:43:16 INFO - Running setup.py install for moznetwork 15:43:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:43:16 INFO - Running setup.py install for mozprocess 15:43:16 INFO - Running setup.py install for mozprofile 15:43:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:43:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:43:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:43:17 INFO - Running setup.py install for mozrunner 15:43:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:43:17 INFO - Running setup.py install for mozscreenshot 15:43:17 INFO - Running setup.py install for moztest 15:43:17 INFO - Running setup.py install for mozversion 15:43:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:43:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:43:17 INFO - Cleaning up... 15:43:17 INFO - Return code: 0 15:43:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:43:17 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')]} 15:43:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:17 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')]} 15:43:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:17 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 0x1f2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229f090>, '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 0x229fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2299f90>, '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': 'af724c981e2a0f424dbabf99000001e7-1504824148.52930-1787114130', '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 15:43:17 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 15:43:17 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 15:43:17 INFO - Using env: {'DISPLAY': ':0', 15:43:17 INFO - 'HOME': '/home/cltbld', 15:43:17 INFO - 'LANG': 'en_US.UTF-8', 15:43:17 INFO - 'LANGUAGE': 'en_US:en', 15:43:17 INFO - 'LOGNAME': 'cltbld', 15:43:17 INFO - 'MAIL': '/var/mail/cltbld', 15:43:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:17 INFO - 'MOZ_NO_REMOTE': '1', 15:43:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:43:17 INFO - 'NO_EM_RESTART': '1', 15:43:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:43:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:17 INFO - 'PWD': '/builds/slave/test', 15:43:17 INFO - 'SHELL': '/bin/bash', 15:43:17 INFO - 'SHLVL': '1', 15:43:17 INFO - 'TERM': 'linux', 15:43:17 INFO - 'TMOUT': '86400', 15:43:17 INFO - 'USER': 'cltbld', 15:43:17 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1504824148.52930-1787114130', 15:43:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:17 INFO - '_': '/tools/buildbot/bin/python'} 15:43:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:43:17 INFO - Running setup.py (path:/tmp/pip-xyRu51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:43:17 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)) 15:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:43:17 INFO - Running setup.py (path:/tmp/pip-6twuIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:43:17 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)) 15:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:43:17 INFO - Running setup.py (path:/tmp/pip-KBSy3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:43:17 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)) 15:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:43:17 INFO - Running setup.py (path:/tmp/pip-Ocpbx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:43:18 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)) 15:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:43:18 INFO - Running setup.py (path:/tmp/pip-Lq0aFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:43:18 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)) 15:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:43:18 INFO - Running setup.py (path:/tmp/pip-WoTS2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:43:18 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)) 15:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:43:18 INFO - Running setup.py (path:/tmp/pip-fFU0mD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:43:18 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)) 15:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:43:18 INFO - Running setup.py (path:/tmp/pip-1Rsxzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:43:18 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)) 15:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:43:18 INFO - Running setup.py (path:/tmp/pip-Bw7Ozx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:43:18 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)) 15:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:43:18 INFO - Running setup.py (path:/tmp/pip-wfmtQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:43:18 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)) 15:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:43:18 INFO - Running setup.py (path:/tmp/pip-LgXVmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:43:18 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)) 15:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:43:18 INFO - Running setup.py (path:/tmp/pip-88CmEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:43:18 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)) 15:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:43:18 INFO - Running setup.py (path:/tmp/pip-l5exs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:43:18 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)) 15:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:43:18 INFO - Running setup.py (path:/tmp/pip-m4sGDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:43:18 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)) 15:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:43:18 INFO - Running setup.py (path:/tmp/pip-41pklQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:43:18 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)) 15:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:43:18 INFO - Running setup.py (path:/tmp/pip-QpC7Ih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:43:18 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)) 15:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:43:18 INFO - Running setup.py (path:/tmp/pip-A2GTXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:43:18 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)) 15:43:18 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)) 15:43:18 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)) 15:43:18 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)) 15:43:18 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)) 15:43:18 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)) 15:43:18 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)) 15:43:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:43:18 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 15:43:18 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 15:43:18 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 15:43:18 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 15:43:20 INFO - Downloading blessings-1.6.tar.gz 15:43:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:43:20 INFO - Installing collected packages: blessings 15:43:20 INFO - Running setup.py install for blessings 15:43:20 INFO - Successfully installed blessings 15:43:20 INFO - Cleaning up... 15:43:20 INFO - Return code: 0 15:43:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:43:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:43:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:43:20 INFO - Reading from file tmpfile_stdout 15:43:20 INFO - Current package versions: 15:43:20 INFO - argparse == 1.2.1 15:43:20 INFO - blessings == 1.6 15:43:20 INFO - blobuploader == 1.2.4 15:43:20 INFO - docopt == 0.6.1 15:43:20 INFO - functools32 == 3.2.3-2 15:43:20 INFO - jsonschema == 2.5.1 15:43:20 INFO - manifestparser == 1.1 15:43:20 INFO - mozInstall == 1.13 15:43:20 INFO - mozcrash == 1.0 15:43:20 INFO - mozdebug == 0.1 15:43:20 INFO - mozdevice == 0.51 15:43:20 INFO - mozfile == 1.2 15:43:20 INFO - mozhttpd == 0.7 15:43:20 INFO - mozinfo == 0.10 15:43:20 INFO - mozleak == 0.1 15:43:20 INFO - mozlog == 3.5 15:43:20 INFO - moznetwork == 0.27 15:43:20 INFO - mozprocess == 0.25 15:43:20 INFO - mozprofile == 0.28 15:43:20 INFO - mozrunner == 6.13 15:43:20 INFO - mozscreenshot == 0.1 15:43:20 INFO - mozsystemmonitor == 0.3 15:43:20 INFO - moztest == 0.8 15:43:20 INFO - mozversion == 1.4 15:43:20 INFO - psutil == 3.1.1 15:43:20 INFO - requests == 1.2.3 15:43:20 INFO - wsgiref == 0.1.2 15:43:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:43:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:20 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 0x1f2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229f090>, '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 0x229fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2299f90>, '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': 'af724c981e2a0f424dbabf99000001e7-1504824148.52930-1787114130', '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 15:43:20 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 15:43:20 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 15:43:20 INFO - Using env: {'DISPLAY': ':0', 15:43:20 INFO - 'HOME': '/home/cltbld', 15:43:20 INFO - 'LANG': 'en_US.UTF-8', 15:43:20 INFO - 'LANGUAGE': 'en_US:en', 15:43:20 INFO - 'LOGNAME': 'cltbld', 15:43:20 INFO - 'MAIL': '/var/mail/cltbld', 15:43:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:20 INFO - 'MOZ_NO_REMOTE': '1', 15:43:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:43:20 INFO - 'NO_EM_RESTART': '1', 15:43:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:43:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:20 INFO - 'PWD': '/builds/slave/test', 15:43:20 INFO - 'SHELL': '/bin/bash', 15:43:20 INFO - 'SHLVL': '1', 15:43:20 INFO - 'TERM': 'linux', 15:43:20 INFO - 'TMOUT': '86400', 15:43:20 INFO - 'USER': 'cltbld', 15:43:20 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1504824148.52930-1787114130', 15:43:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:20 INFO - '_': '/tools/buildbot/bin/python'} 15:43:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:20 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)) 15:43:20 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)) 15:43:20 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)) 15:43:20 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)) 15:43:20 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)) 15:43:20 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)) 15:43:20 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)) 15:43:20 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)) 15:43:20 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)) 15:43:20 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:43:21 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)) 15:43:21 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)) 15:43:21 INFO - Installing collected packages: simplejson 15:43:21 INFO - Running setup.py install for simplejson 15:43:22 INFO - building 'simplejson._speedups' extension 15:43:22 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 15:43:22 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 15:43:22 INFO - Successfully installed simplejson 15:43:22 INFO - Cleaning up... 15:43:22 INFO - Return code: 0 15:43:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:43:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:22 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 0x1f2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229f090>, '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 0x229fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2299f90>, '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': 'af724c981e2a0f424dbabf99000001e7-1504824148.52930-1787114130', '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 15:43:22 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 15:43:22 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 15:43:22 INFO - Using env: {'DISPLAY': ':0', 15:43:22 INFO - 'HOME': '/home/cltbld', 15:43:22 INFO - 'LANG': 'en_US.UTF-8', 15:43:22 INFO - 'LANGUAGE': 'en_US:en', 15:43:22 INFO - 'LOGNAME': 'cltbld', 15:43:22 INFO - 'MAIL': '/var/mail/cltbld', 15:43:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:22 INFO - 'MOZ_NO_REMOTE': '1', 15:43:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:43:22 INFO - 'NO_EM_RESTART': '1', 15:43:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:43:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:22 INFO - 'PWD': '/builds/slave/test', 15:43:22 INFO - 'SHELL': '/bin/bash', 15:43:22 INFO - 'SHLVL': '1', 15:43:22 INFO - 'TERM': 'linux', 15:43:22 INFO - 'TMOUT': '86400', 15:43:22 INFO - 'USER': 'cltbld', 15:43:22 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1504824148.52930-1787114130', 15:43:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:22 INFO - '_': '/tools/buildbot/bin/python'} 15:43:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:43:23 INFO - Cleaning up... 15:43:23 INFO - Return code: 0 15:43:23 INFO - Running post-action listener: _resource_record_post_action 15:43:23 INFO - Running post-action listener: _start_resource_monitoring 15:43:23 INFO - Starting resource monitoring. 15:43:23 INFO - [mozharness: 2017-09-07 22:43:23.242973Z] Finished create-virtualenv step (success) 15:43:23 INFO - [mozharness: 2017-09-07 22:43:23.243480Z] Running install step. 15:43:23 INFO - Running pre-action listener: _resource_record_pre_action 15:43:23 INFO - Running main action method: install 15:43:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:43:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:43:23 INFO - Reading from file tmpfile_stdout 15:43:23 INFO - Detecting whether we're running mozinstall >=1.0... 15:43:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:43:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:43:23 INFO - Reading from file tmpfile_stdout 15:43:23 INFO - Output received: 15:43:23 INFO - Usage: mozinstall [options] installer 15:43:23 INFO - Options: 15:43:23 INFO - -h, --help show this help message and exit 15:43:23 INFO - -d DEST, --destination=DEST 15:43:23 INFO - Directory to install application into. [default: 15:43:23 INFO - "/builds/slave/test"] 15:43:23 INFO - --app=APP Application being installed. [default: firefox] 15:43:23 INFO - mkdir: /builds/slave/test/build/application 15:43:23 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'] 15:43:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:43:41 INFO - Reading from file tmpfile_stdout 15:43:41 INFO - Output received: 15:43:41 INFO - /builds/slave/test/build/application/firefox/firefox 15:43:41 INFO - Running post-action listener: _resource_record_post_action 15:43:41 INFO - [mozharness: 2017-09-07 22:43:41.533697Z] Finished install step (success) 15:43:41 INFO - [mozharness: 2017-09-07 22:43:41.533951Z] Running setup-mitmproxy step. 15:43:41 INFO - Running pre-action listener: _resource_record_pre_action 15:43:41 INFO - Running main action method: setup_mitmproxy 15:43:41 INFO - Skipping: mitmproxy is not required 15:43:41 INFO - Running post-action listener: _resource_record_post_action 15:43:41 INFO - [mozharness: 2017-09-07 22:43:41.535141Z] Finished setup-mitmproxy step (success) 15:43:41 INFO - [mozharness: 2017-09-07 22:43:41.535360Z] Running run-tests step. 15:43:41 INFO - Running pre-action listener: _resource_record_pre_action 15:43:41 INFO - Running pre-action listener: _set_gcov_prefix 15:43:41 INFO - Running main action method: run_tests 15:43:41 WARNING - Try message not found. 15:43:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:43:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:43:41 INFO - Python 2.7.3 15:43:41 INFO - Return code: 0 15:43:41 INFO - grabbing minidump binary from tooltool 15:43:41 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')]} 15:43:41 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 0x229f090>, '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 0x229fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2299f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:43:41 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 15:43:41 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 15:43:41 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 15:43:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:43:41 INFO - Return code: 0 15:43:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:43:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:43:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:43:41 INFO - ENV: RUST_BACKTRACE is now full 15:43:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:43:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:43:41 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-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 15:43:41 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-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-020 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 15:43:41 INFO - Using env: {'DISPLAY': ':0', 15:43:41 INFO - 'HOME': '/home/cltbld', 15:43:41 INFO - 'LANG': 'en_US.UTF-8', 15:43:41 INFO - 'LANGUAGE': 'en_US:en', 15:43:41 INFO - 'LOGNAME': 'cltbld', 15:43:41 INFO - 'MAIL': '/var/mail/cltbld', 15:43:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:43:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:43:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:41 INFO - 'MOZ_NO_REMOTE': '1', 15:43:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:43:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:43:41 INFO - 'NO_EM_RESTART': '1', 15:43:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:43:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:41 INFO - 'PWD': '/builds/slave/test', 15:43:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:43:41 INFO - 'RUST_BACKTRACE': 'full', 15:43:41 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:43:41 INFO - 'SHELL': '/bin/bash', 15:43:41 INFO - 'SHLVL': '1', 15:43:41 INFO - 'TERM': 'linux', 15:43:41 INFO - 'TMOUT': '86400', 15:43:41 INFO - 'USER': 'cltbld', 15:43:41 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1504824148.52930-1787114130', 15:43:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:41 INFO - '_': '/tools/buildbot/bin/python'} 15:43:41 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-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 15:43:41 INFO - mozversion application_buildid: 20170907215054 15:43:41 INFO - mozversion application_changeset: 64bf417d1bdf9bb8b562d73cc0742b1ec60a8d0e 15:43:41 INFO - mozversion application_display_name: Nightly 15:43:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:43:41 INFO - mozversion application_name: Firefox 15:43:41 INFO - mozversion application_remotingname: firefox 15:43:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:43:41 INFO - mozversion application_vendor: Mozilla 15:43:41 INFO - mozversion application_version: 57.0a1 15:43:41 INFO - mozversion platform_buildid: 20170907215054 15:43:41 INFO - mozversion platform_changeset: 64bf417d1bdf9bb8b562d73cc0742b1ec60a8d0e 15:43:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:43:41 INFO - mozversion platform_version: 57.0a1 15:43:41 INFO - using testdate: 1504824221 15:43:41 INFO - actual date: 1504824221 15:43:41 INFO - starting webserver on 'localhost:51206' 15:43:41 INFO - SUITE-START | Running 2 tests 15:43:41 INFO - TEST-START | dromaeo_css 15:43:41 INFO - Initialising browser for dromaeo_css test... 15:43:41 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51206/getInfo.html -profile /tmp/tmp5SMuRI/profile 15:43:41 INFO - TEST-INFO | started process 24410 (/builds/slave/test/build/application/firefox/firefox http://localhost:51206/getInfo.html) 15:43:48 INFO - TEST-INFO | 24410: exit 0 15:43:48 INFO - Browser initialized. 15:43:48 INFO - Running cycle 1/1 for dromaeo_css test... 15:43:48 INFO - Using env: {'DISPLAY': ':0', 15:43:48 INFO - 'HOME': '/home/cltbld', 15:43:48 INFO - 'JSGC_DISABLE_POISONING': '1', 15:43:48 INFO - 'LANG': 'en_US.UTF-8', 15:43:48 INFO - 'LANGUAGE': 'en_US:en', 15:43:48 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:43:48 INFO - 'LOGNAME': 'cltbld', 15:43:48 INFO - 'MAIL': '/var/mail/cltbld', 15:43:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:43:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:43:48 INFO - 'MOZ_CRASHREPORTER': '1', 15:43:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:48 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:43:48 INFO - 'MOZ_NO_REMOTE': '1', 15:43:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:43:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:43:48 INFO - 'NO_EM_RESTART': '1', 15:43:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:43:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:48 INFO - 'PWD': '/builds/slave/test', 15:43:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:43:48 INFO - 'RUST_BACKTRACE': 'full', 15:43:48 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:43:48 INFO - 'SHELL': '/bin/bash', 15:43:48 INFO - 'SHLVL': '1', 15:43:48 INFO - 'STYLO_FORCE_DISABLED': '1', 15:43:48 INFO - 'TERM': 'linux', 15:43:48 INFO - 'TMOUT': '86400', 15:43:48 INFO - 'USER': 'cltbld', 15:43:48 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1504824148.52930-1787114130', 15:43:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:48 INFO - '_': '/tools/buildbot/bin/python'} 15:43:48 INFO - TEST-INFO | started process 24609 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5SMuRI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:43:49 INFO - PID 24609 | 15:43:49 INFO - PID 24609 | (/builds/slave/test/build/application/firefox/firefox:24659): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:43:49 INFO - PID 24609 | 15:44:00 INFO - PID 24609 | RSS: Main: 164347904 15:44:00 INFO - PID 24609 | 15:46:57 INFO - PID 24609 | Cycle 1(1): loaded http://localhost:51206/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51206/tests/dromaeo/cssquery-ext.html) 15:46:58 INFO - PID 24609 | RSS: Main: 170737664 15:46:58 INFO - PID 24609 | 15:50:00 INFO - PID 24609 | Cycle 1(1): loaded http://localhost:51206/tests/dromaeo/cssquery-ext.html (next: http://localhost:51206/tests/dromaeo/cssquery-jquery.html) 15:50:00 INFO - PID 24609 | RSS: Main: 166887424 15:50:00 INFO - PID 24609 | 15:53:02 INFO - PID 24609 | Cycle 1(1): loaded http://localhost:51206/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51206/tests/dromaeo/cssquery-mootools.html) 15:53:03 INFO - PID 24609 | RSS: Main: 169218048 15:53:03 INFO - PID 24609 | 15:56:05 INFO - PID 24609 | Cycle 1(1): loaded http://localhost:51206/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51206/tests/dromaeo/cssquery-prototype.html) 15:56:05 INFO - PID 24609 | RSS: Main: 168013824 15:56:05 INFO - PID 24609 | 15:59:08 INFO - PID 24609 | Cycle 1(1): loaded http://localhost:51206/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51206/tests/dromaeo/cssquery-yui.html) 15:59:09 INFO - PID 24609 | RSS: Main: 169259008 15:59:09 INFO - PID 24609 | 16:02:11 INFO - PID 24609 | Cycle 1(1): loaded http://localhost:51206/tests/dromaeo/cssquery-yui.html (next: http://localhost:51206/tests/dromaeo/cssquery-dojo.html) 16:02:11 INFO - PID 24609 | RSS: Main: 172613632 16:02:11 INFO - PID 24609 | 16:02:11 INFO - PID 24609 | __start_tp_report 16:02:11 INFO - PID 24609 | _x_x_mozilla_page_load 16:02:11 INFO - PID 24609 | _x_x_mozilla_page_load_details 16:02:11 INFO - PID 24609 | |i|pagename|runs| 16:02:11 INFO - PID 24609 | |0;dojo.html;3068.861901214445;3076.6923307669235;3127.0462508934793;3134.0754477429155;3134.169445097048;6077.392260773931;6238.6256824590555;6290.087937249096;6325.746970121189;6332.303446620868;6191.628502289855;6218.347073557268;6241.563090583661;6248.15649887265;6256.968715156429;5753.108268218432;5783.566232532556;5875.618084824473;5877.441643043925;5886.558508111887;5826.359100498963;5852.564387595292;5868.530517558585;5917.112433135043;5941.019731744257;5543.861403464925;5644.463775941279;5814.592978491507;5843.357230704619;5938.792142275021;5738.483536481736;5750.712464376765;5830.0380437227805;5836.5622578306375;5841.474267315962;5617.045102332613;5732.254806875121;5754.597178197486;5809.506191973687;5812.534997200214;6086.2087928569;6092.939070609282;6148.723307451175;6153;6163.753449862;6594.07682924391;6600.537962342638;6604.273529911706;6639.568428052161;6745.763898263586;6806.693698783517;6813.250542440328;6818.2159051709195;6821;6827.180738311385;5944.940550594482;6118.235220597381;6339.778107766206;6340.365963403623;6353.6823158842335;6781.186257649015;6792.796216113525;6800.115984921928;6820.181578210647;6837.726490940307;6477;6482.416582507597;6484.935150648433;6497.512686548528;6504.837379065467;6693.866122677519;6752.291009444036;6769.8646027079185;6804.183497980175;6848.452123830081;6474.546781725328;6599.274079851212;6613.86772264552;6710.563813352116;6786.524943254023;6741.056252124707;6747.359000894907;6749.156355455568;6750.3924646782025;6750.898736518858;5260.289860868734;5264.447233040552;5311.760970756325;5328.413874473805;5344.118220493653;4596.5863072323655;4626.1441633297945;4631.490536041033;4660.7436590987145;4674.11191873543;5670.631408958405;5694.97152514243;5735.483806457439;5804.82585522435;5886.823395298063;6750.797476075725;6769.492288078413;6814.863702725917;6823.283555226729;6832.282610325944;5784.421557844182;5799.101139323411;5817.360090390053;5891.941080589225;5901.852453688693;5591.524720398812;5756.395578464285;5757.337906140764;5834.854128646818;5836.824895253149;6284.12022316876;6534.9673251634385;6608.471322294205;6644.833879152963;6662.467002639777;6709.563878347892;6720.663966801738;6775.830604234737;6783.152105986752;6802.319768023158;6473.190851143607;6496.220453545605;6567.080608714688;6574.934250657623;6581.473482121323;6455.67721613908;6563.901541476977;6635.966820165868;6712.865742685217;6723.125993620798;6744.022116792939;6837.521373503807;6863.519553631198;6874.243833178246;6875.346842049998;6360.395762402564;6541.574797638138;6545.541812073109;6618.669066546557;6642.535022548375;6365.713542890674;6383.648899310582;6390.616563006234;6391.296957334783;6399.840003999937;6341.143945567289;6350.237971443456;6412.070249813658;6509.381608747161;6535.901961470677;6521;6591.143151390289;6644.202695676549;6688.83277918056;6695.765648202289;6145.016797312409;6231.750729970931;6369.394907483782;6373.075903993988;6468.029795530708 16:02:11 INFO - PID 24609 | |1;ext.html;834.5159807311755;864.852974994251;887.1970866365941;890.9955450222748;892.8392889279932;40542.39186412202;41139.58860411399;41361.58638413615;41446.17107657849;41528;38362.808185959104;38394;38420.23159536807;38460.23079538408;38714.8064259679;6905.482088843331;7012.929870701304;7020.754273600425;7053.188883278412;7053.576785392867;6949.722011119549;7040.894386584206;7045.647717614099;7046.401055910228;7096.361327480526;7082.610456424894;7086.57480551166;7097.929020709778;7104.254053324404;7109.928900711005;7606.125295590995;7816;7875.251851074138;7876.842463150733;7881.842363152762;7681.615919204018;7761.6119194040075;7765.495242809256;7767.572783496906;7844;37805.432918506245;37997.62002379968;38288.80855595732;38656.22687546234;38694.419583706265;3545.0428384336083;3591.2637909228547;3591.497190393347;3592.802395868226;3594.4608308753636;32241.1939701507;32326.19184520406;32442.026739197863;32463.51304730431;32493.51259731106;5216.26972223889;5236.842894713165;5268.367795864482;5281.63028587999;5314.548263397616;180221;181101.9999999987;181638;181780;184532;45741;46319.53680463152;46370.53629463662;46446.374376896645;46454.30318545225;49830.50169498331;49837;49898.501014989386;49901;49919;15552.455664051704;15742.291596878167;15764.76352854708;15776.526704198663;15918.363265469252;13023.283719395335;13077.738445231233;13081.803772943413;13104.934475327753;13123.475060997644;13660.385282662304;13762.931185344009;13826.239556824472;13930.164190148624;13939.512117075854;5630.60585758993;5644.8306550803545;5679.602427830095;5710.771569137271;5729.541636669056;1008.6620981970975;1019.6431249062769;1025.6820385680462;1026.2046913641987;1038.4392428088747;22825.657615135788;22879.7712022881;22893;23051.423714407272;23353.182638607566;1099.0273607856943;1117.2570240789946;1122.3882983773863;1128.2779021426293;1146.4554336690005;12291.262524248574;12291.692707682201;12530.37348132608;12562.309073001074;12595.370231488389;240640;241650;242272;242662;243088;52648.473515264355;55599.444005559424;56066.43933560612;56573.43426565682;56626.15060774009;1413.9363728632236;1446.6528033271939;1448.3061505599576;1451.4194322271176;1453.9491117811037;27747.44505109927;27899.721002789713;27948.16155515338;28094.2976425591;28282;38128.42807357836;38376;38385.808070959465;38399.616003840725;38512.42231366588;201896;202312;202545;202679;202910;34106;35413.29173416569;35993.820030899675;36067.81966090153;36152.4577131338;42604.78697606492;43569.56430435655;43781;43983.78008109939;44072.55927440685;31505.684943150274;31832.204194895312;32114.678853211168;32149.196270093435;32202.83898580492;31762.84118579485;32178;32302;32385.838070809496;32902.67097328996;35941;36184;36278;36283.637163628024;36444.45333320055;30706.539401909435;31064.378712425172;31233.687663123077;31254.374912502077;31361;22870.284728645085;23240.033081897465;23278;23465.765342346356;23492 16:02:11 INFO - PID 24609 | |2;jquery.html;558.1989844573038;568.414533030978;573.9311282646083;578.4793685682886;597.7907732293697;21938.89030554847;22622.43443913903;22711.31866044017;22815;22888.31335059951;24472.388190295253;24787.380315492075;24929.87535062322;26164.86917565414;26367.20898373047;6721.764738234163;6873.381395674388;6876.931230687679;6878.037074809531;6880.2775708550635;6314.084457753623;6583.868322633544;6662.067310576524;6711.395974362306;6714.865702685944;6547.869042619169;6554.836129096763;6556.409923106919;6559.63921984293;6560;6544.869102617969;6557.836054098638;6558.540902136852;6559.770408035696;6562.048502967067;6062.363451837582;6091.878162436727;6093;6096.908546371808;6107.4197951194565;28074.578881316796;28854.567181492293;29161.270968225752;29192.416151676847;29427.41145177106;1948.795376485477;1992.2529051605648;1993.2624928776302;1994.3418671838258;1996.900154992259;18987.71518427225;19405.708914366154;19810.40568782939;19813.504662383413;19869;2450.901963921441;2458.938526536833;2490.5766019776684;2503.7120731115974;2505.987470062656;117656;123783.381083094;124892.75107248902;130553.6944630551;134438.3278083613;14903.254837258093;14948.814331987061;15092.924535377253;15247.3901043957;15466.381344746309;22799.544009119723;22812.4296892579;22818.65772013421;22819.429514261945;22820.885895570747;10174.949125254327;10188.235882308856;10303;10345.224108191916;10416.958304169673;9633.373830701123;9691.321607487549;9737.07497787709;9775.120239178366;9844.655437059668;9148.2681385489;9154.72535823913;9303.76740581491;9354.532273386303;9445.244380449547;2687.3953360493733;2713.552263876478;2812.4796912570832;2812.918440354164;2900.4054168895327;933.3746389918771;973.3673112476805;977.9877826449733;984.7341217871135;987.111599560387;19212.231510739413;19350.612987740165;19356.419307420518;19467.90266048661;19610.50973725668;1033.8242498775226;1035.4512108582464;1047.4291511126303;1047.7642530430744;1051.1958351860833;12513.74972500545;13261.66845828862;13291.867081329063;13574.04981651275;13648.931755341358;440937;453129;483926;488707;492055;112980.43509782398;116411;118386.40806796083;118726;119530.8046919537;1074.382230217628;1122.2929554380687;1187.2460987273143;1218.8781121887919;1249.2816630437535;19753.308634197732;20178.59642807165;20343.389698309074;20380.18479260813;20444.182232710526;58072.12891806542;58251.70874145602;59251;59277.703611481666;59367.40632593619;73265;76219.61890190735;78657.60671196607;79015.60492197733;80312.59843700977;14384.568462946128;14776.408943642135;14829.629259268604;14912.881533884785;14941.701165976838;22070.006849691483;23084.192053278726;23294;23511.882440587688;23786.643200352355;16911.746323804906;16969.57576060559;17050.14749262507;17277.65444691124;18716.532086697942;16851.073190974614;16910.492685219462;17284;17395;17609.559761006076;19213.903930480257;19638.410847674593;19686.507837304183;19785.40643780689;20006.69989950123;14437.278136093364;14636.634084147981;14754.852451475348;14802.703945920806;14807.111573305205;18706.532336691147;18813.435596931566;18818.52953676169;19150.521236969187;19181.904090479456 16:02:11 INFO - PID 24609 | |3;mootools.html;1310.122218113864;1397.6505873531614;1412.9222892740895;1412.9576112716616;1413.2933533233384;15714;16163.191840407992;16183.595410114753;16198;16203.351865925379;15858.444954426597;15940.963837350564;16009.35962561499;16013.599660008505;16014;2738.7124351943057;2755.1321333779847;2802.9018984335553;2809.7892658050628;2815.985920070397;2737.5619900815873;2770.473610014101;2788.7211278872155;2791.5533514637664;2795.343094372821;2637.9472410551775;2741.7669498092687;2866.6130072440164;2868.3689588290545;2886.653601567815;2751.4497100579865;2776.9028084016963;2796.8042237043414;2802.7337402946687;2807.536756435186;2607.2308668942705;2816.774658027353;2846.8434236117005;2850.800443968923;2853.785966052554;15114.54656360311;15195.772063419057;15225.695486090217;15227.238638068164;15238.771418428732;7922.524648521049;8256.958715206385;8264.008319001758;8264.628091735887;8271.296939760128;5214.191800270964;5314.362276526803;5390.9191362129595;5439.728013599304;5443.700596467193;1729.6367762769833;1732.1858726398698;1739.060907110159;1764.038598963568;1772.9024903630295;26489.73510264892;27125.593116103275;27201;27245.59131613047;27309.590356144672;7218.566885986857;7359.852802943911;7365.631718414058;7485.925140748632;7546.396288296923;19771.40685779429;19907.601847963248;20080.69878951817;20096.39710808678;20123;8043.879341809878;8257.92646955904;8263.628136733862;8270.214329638675;8291.626876790559;7234.457415693739;7386.335229829341;7455.291747283999;7483.812904677427;7489.700411983568;5393.514583687487;5571.832845014656;5590.496855283044;5629.296337957755;5635.886542546545;1741.4514427955153;1787.705028670255;1788.4455818696247;1820.099050969752;1825.014492174211;880.5289170293862;903.7830920579014;915.1169121797498;917.4082716647858;917.8760867282965;7498.137714162832;7549.509281896769;7549.6225188740345;7563.092428908456;7599.316061554487;722.3823630795699;725.365305357812;731.5661303844524;742.6954948471101;748.6892939430185;5257.6845389276;5280.867978300496;5285.68285902847;5393.78424863009;5447.237386765856;20222.29221977253;21607.89196054041;21725.56548869014;21747.45631359197;21750.34748957534;20325.593488130155;21288.148474061174;21312.78687213139;21352;21370.679439808417;11186.944065279784;11478.483468243949;11483.885161148448;11495.252808567417;11497.482613282422;8671.6097775599;8813.867791982997;8909.376343655882;8987.370884038317;9034.86447703272;17942.37201697934;18185.81814181894;18373.632527349644;18616;18774.624507510045;19002.714959275898;19075.04624768728;19235.230590776213;19469.221231150594;20206.292779753225;14024.878009759399;14142.292885355486;14305.64235894111;14349.210793406462;14386.208758517963;13938.58184254474;14160.504382346568;14181.645458863612;14190.858091418953;14196;11413.828792567952;11616.88383116158;11741.354225517678;11883.16817822744;12080.939595301967;11100.722481938015;11102;11205.71985700364;11231.606893758679;11516.481758321062;9513.381630194015;9839.065288797552;9839.803203936024;9843.95078024634;9844.409335439897;7554.244575542401;7594.5063570867715;7606;7723.806904827425;7728.188540203198;7766.417518686234;7786.26030527099;7792.922070779219;7885.408594355332;7885.526868387915 16:02:11 INFO - PID 24609 | |4;prototype.html;492.94552307272687;506.821639687726;518.2537146509025;523.4817530644661;528.0725352463508;6107.755689772409;6187.72155253013;6197.814065578029;6235.812925612227;6250.624962502247;6114.388561143884;6124.877502449948;6128.295246046706;6130.478909292704;6143.32423433422;4840.6369522285795;4898.828541001057;4999.625028122887;5015.84952451427;5031.4465408805;5001.8499445016705;5015.3730783652045;5017.247412888059;5052.191649336107;5076.873078173038;4904.877378065541;4906.681065730734;4955.132851750929;4960.33035540201;4968.130577149002;4882.829100981467;4887.902241955177;4962.60299176065;4984.252362145671;4984.40187177541;4428.31361139024;4496.910061798779;4499.595036446703;4526;4527.796249168795;6070;6105.297890742532;6112.786052488186;6194.96902515489;6211.223597050369;5623.353314368859;5696.458836410535;5700.914486282709;5703.287089113861;5729.341125770548;6481.513886458487;6554.70503827329;6577.04632828242;6606.735730570771;6620.2195078067325;4832.444268909086;4833.444153922309;4863.562279394836;4882.707037577757;4904.803807847682;6837.435961514432;6842.897356539655;6895.931040689629;6902.171739391255;6927.792166234971;4942.827001054946;4977.950220497749;4990.303296879006;5012.749362531858;5013.298138260647;4993.827684957056;5027.120253955543;5035.79856805731;5045.596352291808;5064.898702025939;5616.85957851057;5632;5685.744141513642;5687.175359572839;5697.57268204878;6233.597440575834;6300.21247344082;6448.355164483608;6528.934710652833;6559.770408035696;1713.9657206856043;1728.3345911824038;1734.9937036518788;1755.8683098767387;1767.2135899524844;1191.6127258640977;1202.4528839378238;1203.3682316783584;1215.8844909733562;1241.1808206583612;5630.662160270397;5706.429357064343;5770.6249093808765;5778.3354914184565;5821.679807610622;6599.241087274929;6640.302768209365;6700.932990670129;6703.413673684556;6712.42944349726;5681.659100453903;5692.886142277214;5704.3154821421695;5711.7144142792695;5780.624259423208;3525.665061819123;3551.827896794052;3558.323918455537;3566.28674265148;3572.6070132285427;6453.741850326029;6540.574862633914;6540.803775886636;6542.1168142300185;6586.6288136270905;6868.450523958071;6868.587884726832;6895.896561551581;6907.412869906114;6917.754804135203;6458.6770661466735;6485.513586480938;6513.902291465632;6523.217213934358;6596.340365963557;6595.769148079794;6706.865862682816;6726.764563240263;6818.761088483129;6847.1783385994;6593.769218077345;6652.966735166293;6691.1636045494315;6769.323067693192;6772.830679233059;6415.775447859302;6564.538298138198;6568.1789776277965;6626.271110177973;6637.435817955335;4862.513748625109;4929.433115191799;4940.925886111783;4943.678660887031;4974.5771609413605;6711.463082953254;6735.326467353421;6759.898601520883;6767.458603311625;6787.083743694736;6323.3559274588015;6461.903071454026;6531.869362612816;6561.245456772342;6566.343365663395;6503.967480162758;6562.770303039561;6576.704048317742;6581.44057755077;6613.470922326299;6432.903506447501;6443.259025212161;6443.936750436313;6452.419282264619;6459.160309159779;5879.73541190656;6446.742130314922;6476.5466417350335;6565.934340656723;6627.204735431779;6312.968435157978;6316.210473690789;6342.556021078481;6357.554971151975;6411.807645770635 16:02:11 INFO - PID 24609 | |5;yui.html;921.442527271001;923.2567782934735;940.6942743608329;942.618239612957;957.7749228931202;19400.51498712533;20400.591988160228;20521.794782052177;20652.690209646866;20660.8966955165;18461.53846153847;18866.71699924502;18976.430707078776;19234.80765192348;19237.51906202342;968.5883499512714;990.5839547390113;996.4370130876032;996.7956568903394;997.2072202598915;970.6602689058843;996.7657600463922;997.7705127820606;1000.7047920863326;1006.612454205129;1043.306201376084;1060.188955449082;1063.138857525403;1067.1782727299974;1068.1134658233686;1040.4953597505205;1049.569676432659;1052.3896140238644;1053.483792941461;1055.641082032109;765.6018870187471;771.6141929035482;774.5430196184278;774.748206832776;775.1899265267808;20291.492712682153;20703.378898633066;20849.37451876446;20926.686099708517;20928.686069708965;21756.564868702695;21807.890960545097;22199.778002219933;22214.333569992927;22222.333330000125;17195.1402429878;17307.394241201622;17366.826331736647;17440;17485;3651.1419816343137;3672.081979505124;3714.3499887519574;3714.5542534895985;3814.256220037094;111390;137275;138306;140272;141485.29257353648;17347.739783903253;17351.611871050285;17897.910510447364;17907.910460447616;17942.641147176982;29779.10662680123;31911.20221994422;32226.677733222838;32267.51598726021;32427.675723242937;9093.727188184364;9307.90692093084;9329.30030247734;9343.2525397968;9357.578908949114;4390.07808360248;4464.486584042812;4464.665150113755;4469.575390337913;4470.441194850644;5365.248865158881;5449.100898351807;5452.972735136299;5503.477169668875;5524.088525393346;1082.7401423658423;1116.9329840209614;1118.1613789657756;1127.875933647298;1128.1989787251143;675.587891386254;694.6353164588631;701.08508396543;703.1105651351045;704.2710794327846;12386.442610082568;12444.875551244371;12622.495100195889;12915.22508649484;13226.272555009567;641.3105911145537;663.5554178700282;706.251373544045;713.9286071392924;732.1214542548962;6112.235970503687;6167.814965551041;6178.969105154445;6197.752089916353;6345.587536810092;120968.39515802365;121210;124148.37925810313;124405;125750.371248145;85760.57119714361;87234;103098.48450757698;107578.46210768896;113147;82674.58662706648;91376.54311728399;95506;95780.52109739547;96760.51619741856;12437.875621243671;12861.742765144832;12898.419571119135;12967;12981.091323607634;42394.57605424029;42664.360034600126;43005.78497107494;43497.78251108724;43678.12643747044;58234.70882645559;59088.40911590829;77045;85596;87256.56371718101;18997.24011039543;19234.80765192386;19449.222031118596;20151.69772453385;20195;20328.186872525526;20364.083616237007;20387;20764.273250436163;22327.10691572319;19173.137208825356;19762.50593735168;20836;20971.685424718336;21072.262470813446;20137.6979345307;20165.49586260355;20201.79798202058;20482.180712771322;21264.468388290417;17681.469555913343;17808.198631061892;17896.91051544734;18053.819461805215;20541.48646283795;13847.792283115963;14056.929715351358;14095.788563171765;14191.361388737325;14304.928475357972;13059.21644701283;13787.586372408843;13992;14196.006279560332;14526.782098268322 16:02:11 INFO - PID 24609 | __end_tp_report 16:02:11 INFO - PID 24609 | __start_cc_report 16:02:11 INFO - PID 24609 | _x_x_mozilla_cycle_collect,378 16:02:11 INFO - PID 24609 | __end_cc_report 16:02:11 INFO - PID 24609 | __startTimestamp1504825331477__endTimestamp 16:02:11 INFO - PID 24609 | 16:02:11 INFO - PID 24609 | ------- Summary: start ------- 16:02:11 INFO - PID 24609 | Number of tests: 6 16:02:11 INFO - PID 24609 | 16:02:11 INFO - PID 24609 | [#0] dojo.html Cycles:165 Average:6168.55 Median:6369.39 stddev:741.06 (11.6%) stddev-sans-first:702.31 16:02:11 INFO - PID 24609 | Values: 3068.9 3076.7 3127.0 3134.1 3134.2 6077.4 6238.6 6290.1 6325.7 6332.3 6191.6 6218.3 6241.6 6248.2 6257.0 5753.1 5783.6 5875.6 5877.4 5886.6 5826.4 5852.6 5868.5 5917.1 5941.0 5543.9 5644.5 5814.6 5843.4 5938.8 5738.5 5750.7 5830.0 5836.6 5841.5 5617.0 5732.3 5754.6 5809.5 5812.5 6086.2 6092.9 6148.7 6153.0 6163.8 6594.1 6600.5 6604.3 6639.6 6745.8 6806.7 6813.3 6818.2 6821.0 6827.2 5944.9 6118.2 6339.8 6340.4 6353.7 6781.2 6792.8 6800.1 6820.2 6837.7 6477.0 6482.4 6484.9 6497.5 6504.8 6693.9 6752.3 6769.9 6804.2 6848.5 6474.5 6599.3 6613.9 6710.6 6786.5 6741.1 6747.4 6749.2 6750.4 6750.9 5260.3 5264.4 5311.8 5328.4 5344.1 4596.6 4626.1 4631.5 4660.7 4674.1 5670.6 5695.0 5735.5 5804.8 5886.8 6750.8 6769.5 6814.9 6823.3 6832.3 5784.4 5799.1 5817.4 5891.9 5901.9 5591.5 5756.4 5757.3 5834.9 5836.8 6284.1 6535.0 6608.5 6644.8 6662.5 6709.6 6720.7 6775.8 6783.2 6802.3 6473.2 6496.2 6567.1 6574.9 6581.5 6455.7 6563.9 6636.0 6712.9 6723.1 6744.0 6837.5 6863.5 6874.2 6875.3 6360.4 6541.6 6545.5 6618.7 6642.5 6365.7 6383.6 6390.6 6391.3 6399.8 6341.1 6350.2 6412.1 6509.4 6535.9 6521.0 6591.1 6644.2 6688.8 6695.8 6145.0 6231.8 6369.4 6373.1 6468.0 16:02:11 INFO - PID 24609 | 16:02:11 INFO - PID 24609 | [#1] ext.html Cycles:180 Average:37849.87 Median:3593.63 stddev:54527.88 (1517.3%) stddev-sans-first:54610.01 16:02:11 INFO - PID 24609 | Values: 834.5 864.9 887.2 891.0 892.8 40542.4 41139.6 41361.6 41446.2 41528.0 38362.8 38394.0 38420.2 38460.2 38714.8 6905.5 7012.9 7020.8 7053.2 7053.6 6949.7 7040.9 7045.6 7046.4 7096.4 7082.6 7086.6 7097.9 7104.3 7109.9 7606.1 7816.0 7875.3 7876.8 7881.8 7681.6 7761.6 7765.5 7767.6 7844.0 37805.4 37997.6 38288.8 38656.2 38694.4 3545.0 3591.3 3591.5 3592.8 3594.5 32241.2 32326.2 32442.0 32463.5 32493.5 5216.3 5236.8 5268.4 5281.6 5314.5 180221.0 181102.0 181638.0 181780.0 184532.0 45741.0 46319.5 46370.5 46446.4 46454.3 49830.5 49837.0 49898.5 49901.0 49919.0 15552.5 15742.3 15764.8 15776.5 15918.4 13023.3 13077.7 13081.8 13104.9 13123.5 13660.4 13762.9 13826.2 13930.2 13939.5 5630.6 5644.8 5679.6 5710.8 5729.5 1008.7 1019.6 1025.7 1026.2 1038.4 22825.7 22879.8 22893.0 23051.4 23353.2 1099.0 1117.3 1122.4 1128.3 1146.5 12291.3 12291.7 12530.4 12562.3 12595.4 240640.0 241650.0 242272.0 242662.0 243088.0 52648.5 55599.4 56066.4 56573.4 56626.2 1413.9 1446.7 1448.3 1451.4 1453.9 27747.4 27899.7 27948.2 28094.3 28282.0 38128.4 38376.0 38385.8 38399.6 38512.4 201896.0 202312.0 202545.0 202679.0 202910.0 34106.0 35413.3 35993.8 36067.8 36152.5 42604.8 43569.6 43781.0 43983.8 44072.6 31505.7 31832.2 32114.7 32149.2 32202.8 31762.8 32178.0 32302.0 32385.8 32902.7 35941.0 36184.0 36278.0 36283.6 36444.5 30706.5 31064.4 31233.7 31254.4 31361.0 22870.3 23240.0 23278.0 23465.8 23492.0 16:02:11 INFO - PID 24609 | 16:02:11 INFO - PID 24609 | [#2] jquery.html Cycles:180 Average:34377.96 Median:22813.71 stddev:79549.52 (348.7%) stddev-sans-first:79732.15 16:02:11 INFO - PID 24609 | Values: 558.2 568.4 573.9 578.5 597.8 21938.9 22622.4 22711.3 22815.0 22888.3 24472.4 24787.4 24929.9 26164.9 26367.2 6721.8 6873.4 6876.9 6878.0 6880.3 6314.1 6583.9 6662.1 6711.4 6714.9 6547.9 6554.8 6556.4 6559.6 6560.0 6544.9 6557.8 6558.5 6559.8 6562.0 6062.4 6091.9 6093.0 6096.9 6107.4 28074.6 28854.6 29161.3 29192.4 29427.4 1948.8 1992.3 1993.3 1994.3 1996.9 18987.7 19405.7 19810.4 19813.5 19869.0 2450.9 2458.9 2490.6 2503.7 2506.0 117656.0 123783.4 124892.8 130553.7 134438.3 14903.3 14948.8 15092.9 15247.4 15466.4 22799.5 22812.4 22818.7 22819.4 22820.9 10174.9 10188.2 10303.0 10345.2 10417.0 9633.4 9691.3 9737.1 9775.1 9844.7 9148.3 9154.7 9303.8 9354.5 9445.2 2687.4 2713.6 2812.5 2812.9 2900.4 933.4 973.4 978.0 984.7 987.1 19212.2 19350.6 19356.4 19467.9 19610.5 1033.8 1035.5 1047.4 1047.8 1051.2 12513.7 13261.7 13291.9 13574.0 13648.9 440937.0 453129.0 483926.0 488707.0 492055.0 112980.4 116411.0 118386.4 118726.0 119530.8 1074.4 1122.3 1187.2 1218.9 1249.3 19753.3 20178.6 20343.4 20380.2 20444.2 58072.1 58251.7 59251.0 59277.7 59367.4 73265.0 76219.6 78657.6 79015.6 80312.6 14384.6 14776.4 14829.6 14912.9 14941.7 22070.0 23084.2 23294.0 23511.9 23786.6 16911.7 16969.6 17050.1 17277.7 18716.5 16851.1 16910.5 17284.0 17395.0 17609.6 19213.9 19638.4 19686.5 19785.4 20006.7 14437.3 14636.6 14754.9 14802.7 14807.1 18706.5 18813.4 18818.5 19150.5 19181.9 16:02:11 INFO - PID 24609 | 16:02:11 INFO - PID 24609 | [#3] mootools.html Cycles:180 Average:9641.77 Median:2753.29 stddev:6851.80 (248.9%) stddev-sans-first:6842.42 16:02:11 INFO - PID 24609 | Values: 1310.1 1397.7 1412.9 1413.0 1413.3 15714.0 16163.2 16183.6 16198.0 16203.4 15858.4 15941.0 16009.4 16013.6 16014.0 2738.7 2755.1 2802.9 2809.8 2816.0 2737.6 2770.5 2788.7 2791.6 2795.3 2637.9 2741.8 2866.6 2868.4 2886.7 2751.4 2776.9 2796.8 2802.7 2807.5 2607.2 2816.8 2846.8 2850.8 2853.8 15114.5 15195.8 15225.7 15227.2 15238.8 7922.5 8257.0 8264.0 8264.6 8271.3 5214.2 5314.4 5390.9 5439.7 5443.7 1729.6 1732.2 1739.1 1764.0 1772.9 26489.7 27125.6 27201.0 27245.6 27309.6 7218.6 7359.9 7365.6 7485.9 7546.4 19771.4 19907.6 20080.7 20096.4 20123.0 8043.9 8257.9 8263.6 8270.2 8291.6 7234.5 7386.3 7455.3 7483.8 7489.7 5393.5 5571.8 5590.5 5629.3 5635.9 1741.5 1787.7 1788.4 1820.1 1825.0 880.5 903.8 915.1 917.4 917.9 7498.1 7549.5 7549.6 7563.1 7599.3 722.4 725.4 731.6 742.7 748.7 5257.7 5280.9 5285.7 5393.8 5447.2 20222.3 21607.9 21725.6 21747.5 21750.3 20325.6 21288.1 21312.8 21352.0 21370.7 11186.9 11478.5 11483.9 11495.3 11497.5 8671.6 8813.9 8909.4 8987.4 9034.9 17942.4 18185.8 18373.6 18616.0 18774.6 19002.7 19075.0 19235.2 19469.2 20206.3 14024.9 14142.3 14305.6 14349.2 14386.2 13938.6 14160.5 14181.6 14190.9 14196.0 11413.8 11616.9 11741.4 11883.2 12080.9 11100.7 11102.0 11205.7 11231.6 11516.5 9513.4 9839.1 9839.8 9844.0 9844.4 7554.2 7594.5 7606.0 7723.8 7728.2 7766.4 7786.3 7792.9 7885.4 7885.5 16:02:11 INFO - PID 24609 | 16:02:11 INFO - PID 24609 | [#4] prototype.html Cycles:180 Average:5498.55 Median:6119.63 stddev:1546.70 (25.3%) stddev-sans-first:1504.72 16:02:11 INFO - PID 24609 | Values: 492.9 506.8 518.3 523.5 528.1 6107.8 6187.7 6197.8 6235.8 6250.6 6114.4 6124.9 6128.3 6130.5 6143.3 4840.6 4898.8 4999.6 5015.8 5031.4 5001.8 5015.4 5017.2 5052.2 5076.9 4904.9 4906.7 4955.1 4960.3 4968.1 4882.8 4887.9 4962.6 4984.3 4984.4 4428.3 4496.9 4499.6 4526.0 4527.8 6070.0 6105.3 6112.8 6195.0 6211.2 5623.4 5696.5 5700.9 5703.3 5729.3 6481.5 6554.7 6577.0 6606.7 6620.2 4832.4 4833.4 4863.6 4882.7 4904.8 6837.4 6842.9 6895.9 6902.2 6927.8 4942.8 4978.0 4990.3 5012.7 5013.3 4993.8 5027.1 5035.8 5045.6 5064.9 5616.9 5632.0 5685.7 5687.2 5697.6 6233.6 6300.2 6448.4 6528.9 6559.8 1714.0 1728.3 1735.0 1755.9 1767.2 1191.6 1202.5 1203.4 1215.9 1241.2 5630.7 5706.4 5770.6 5778.3 5821.7 6599.2 6640.3 6700.9 6703.4 6712.4 5681.7 5692.9 5704.3 5711.7 5780.6 3525.7 3551.8 3558.3 3566.3 3572.6 6453.7 6540.6 6540.8 6542.1 6586.6 6868.5 6868.6 6895.9 6907.4 6917.8 6458.7 6485.5 6513.9 6523.2 6596.3 6595.8 6706.9 6726.8 6818.8 6847.2 6593.8 6653.0 6691.2 6769.3 6772.8 6415.8 6564.5 6568.2 6626.3 6637.4 4862.5 4929.4 4940.9 4943.7 4974.6 6711.5 6735.3 6759.9 6767.5 6787.1 6323.4 6461.9 6531.9 6561.2 6566.3 6504.0 6562.8 6576.7 6581.4 6613.5 6432.9 6443.3 6443.9 6452.4 6459.2 5879.7 6446.7 6476.5 6565.9 6627.2 6313.0 6316.2 6342.6 6357.6 6411.8 16:02:11 INFO - PID 24609 | 16:02:11 INFO - PID 24609 | [#5] yui.html Cycles:180 Average:25132.73 Median:20733.83 stddev:34522.53 (166.5%) stddev-sans-first:34571.51 16:02:11 INFO - PID 24609 | Values: 921.4 923.3 940.7 942.6 957.8 19400.5 20400.6 20521.8 20652.7 20660.9 18461.5 18866.7 18976.4 19234.8 19237.5 968.6 990.6 996.4 996.8 997.2 970.7 996.8 997.8 1000.7 1006.6 1043.3 1060.2 1063.1 1067.2 1068.1 1040.5 1049.6 1052.4 1053.5 1055.6 765.6 771.6 774.5 774.7 775.2 20291.5 20703.4 20849.4 20926.7 20928.7 21756.6 21807.9 22199.8 22214.3 22222.3 17195.1 17307.4 17366.8 17440.0 17485.0 3651.1 3672.1 3714.3 3714.6 3814.3 111390.0 137275.0 138306.0 140272.0 141485.3 17347.7 17351.6 17897.9 17907.9 17942.6 29779.1 31911.2 32226.7 32267.5 32427.7 9093.7 9307.9 9329.3 9343.3 9357.6 4390.1 4464.5 4464.7 4469.6 4470.4 5365.2 5449.1 5453.0 5503.5 5524.1 1082.7 1116.9 1118.2 1127.9 1128.2 675.6 694.6 701.1 703.1 704.3 12386.4 12444.9 12622.5 12915.2 13226.3 641.3 663.6 706.3 713.9 732.1 6112.2 6167.8 6179.0 6197.8 6345.6 120968.4 121210.0 124148.4 124405.0 125750.4 85760.6 87234.0 103098.5 107578.5 113147.0 82674.6 91376.5 95506.0 95780.5 96760.5 12437.9 12861.7 12898.4 12967.0 12981.1 42394.6 42664.4 43005.8 43497.8 43678.1 58234.7 59088.4 77045.0 85596.0 87256.6 18997.2 19234.8 19449.2 20151.7 20195.0 20328.2 20364.1 20387.0 20764.3 22327.1 19173.1 19762.5 20836.0 20971.7 21072.3 20137.7 20165.5 20201.8 20482.2 21264.5 17681.5 17808.2 17896.9 18053.8 20541.5 13847.8 14056.9 14095.8 14191.4 14304.9 13059.2 13787.6 13992.0 14196.0 14526.8 16:02:11 INFO - PID 24609 | -------- Summary: end -------- 16:02:11 INFO - PID 24609 | 16:02:12 INFO - TEST-INFO | 24609: exit 0 16:02:12 INFO - TEST-OK | dromaeo_css | took 1110440ms 16:02:12 INFO - TEST-START | kraken 16:02:12 INFO - Initialising browser for kraken test... 16:02:12 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51206/getInfo.html -profile /tmp/tmp1ZQc0W/profile 16:02:12 INFO - TEST-INFO | started process 24982 (/builds/slave/test/build/application/firefox/firefox http://localhost:51206/getInfo.html) 16:02:18 INFO - TEST-INFO | 24982: exit 0 16:02:18 INFO - Browser initialized. 16:02:18 INFO - Running cycle 1/1 for kraken test... 16:02:18 INFO - Using env: {'DISPLAY': ':0', 16:02:18 INFO - 'HOME': '/home/cltbld', 16:02:18 INFO - 'JSGC_DISABLE_POISONING': '1', 16:02:18 INFO - 'LANG': 'en_US.UTF-8', 16:02:18 INFO - 'LANGUAGE': 'en_US:en', 16:02:18 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:02:18 INFO - 'LOGNAME': 'cltbld', 16:02:18 INFO - 'MAIL': '/var/mail/cltbld', 16:02:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:02:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:02:18 INFO - 'MOZ_CRASHREPORTER': '1', 16:02:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:18 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:02:18 INFO - 'MOZ_NO_REMOTE': '1', 16:02:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:02:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:18 INFO - 'NO_EM_RESTART': '1', 16:02:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:18 INFO - 'PWD': '/builds/slave/test', 16:02:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:02:18 INFO - 'RUST_BACKTRACE': 'full', 16:02:18 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:02:18 INFO - 'SHELL': '/bin/bash', 16:02:18 INFO - 'SHLVL': '1', 16:02:18 INFO - 'STYLO_FORCE_DISABLED': '1', 16:02:18 INFO - 'TERM': 'linux', 16:02:18 INFO - 'TMOUT': '86400', 16:02:18 INFO - 'USER': 'cltbld', 16:02:18 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1504824148.52930-1787114130', 16:02:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:18 INFO - '_': '/tools/buildbot/bin/python'} 16:02:18 INFO - TEST-INFO | started process 25179 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1ZQc0W/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:02:19 INFO - PID 25179 | 16:02:19 INFO - PID 25179 | (/builds/slave/test/build/application/firefox/firefox:25230): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:02:19 INFO - PID 25179 | 16:02:29 INFO - PID 25179 | RSS: Main: 169439232 16:02:29 INFO - PID 25179 | 16:02:32 INFO - PID 25179 | Cycle 1(1): loaded http://localhost:51206/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51206/tests/kraken/driver.html?testName=audio-beat-detection) 16:02:33 INFO - PID 25179 | RSS: Main: 176013312 16:02:33 INFO - PID 25179 | 16:02:35 INFO - PID 25179 | Cycle 1(1): loaded http://localhost:51206/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51206/tests/kraken/driver.html?testName=audio-dft) 16:02:36 INFO - PID 25179 | RSS: Main: 176402432 16:02:36 INFO - PID 25179 | 16:02:39 INFO - PID 25179 | Cycle 1(1): loaded http://localhost:51206/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51206/tests/kraken/driver.html?testName=audio-fft) 16:02:39 INFO - PID 25179 | RSS: Main: 170962944 16:02:39 INFO - PID 25179 | 16:02:42 INFO - PID 25179 | Cycle 1(1): loaded http://localhost:51206/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51206/tests/kraken/driver.html?testName=audio-oscillator) 16:02:42 INFO - PID 25179 | RSS: Main: 171651072 16:02:42 INFO - PID 25179 | 16:02:44 INFO - PID 25179 | Cycle 1(1): loaded http://localhost:51206/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51206/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:02:45 INFO - PID 25179 | RSS: Main: 171954176 16:02:45 INFO - PID 25179 | 16:02:48 INFO - PID 25179 | Cycle 1(1): loaded http://localhost:51206/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51206/tests/kraken/driver.html?testName=imaging-darkroom) 16:02:49 INFO - PID 25179 | RSS: Main: 174374912 16:02:49 INFO - PID 25179 | 16:02:52 INFO - PID 25179 | Cycle 1(1): loaded http://localhost:51206/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51206/tests/kraken/driver.html?testName=imaging-desaturate) 16:02:53 INFO - PID 25179 | RSS: Main: 174047232 16:02:53 INFO - PID 25179 | 16:02:56 INFO - PID 25179 | Cycle 1(1): loaded http://localhost:51206/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51206/tests/kraken/driver.html?testName=json-parse-financial) 16:02:56 INFO - PID 25179 | RSS: Main: 174333952 16:02:56 INFO - PID 25179 | 16:02:58 INFO - PID 25179 | Cycle 1(1): loaded http://localhost:51206/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51206/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:02:59 INFO - PID 25179 | RSS: Main: 174305280 16:02:59 INFO - PID 25179 | 16:03:00 INFO - PID 25179 | Cycle 1(1): loaded http://localhost:51206/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51206/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:03:01 INFO - PID 25179 | RSS: Main: 174583808 16:03:01 INFO - PID 25179 | 16:03:03 INFO - PID 25179 | Cycle 1(1): loaded http://localhost:51206/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51206/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:03:04 INFO - PID 25179 | RSS: Main: 171479040 16:03:04 INFO - PID 25179 | 16:03:07 INFO - PID 25179 | Cycle 1(1): loaded http://localhost:51206/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51206/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:03:07 INFO - PID 25179 | RSS: Main: 172339200 16:03:07 INFO - PID 25179 | 16:03:10 INFO - PID 25179 | Cycle 1(1): loaded http://localhost:51206/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51206/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:03:11 INFO - PID 25179 | RSS: Main: 172298240 16:03:11 INFO - PID 25179 | 16:03:13 INFO - PID 25179 | Cycle 1(1): loaded http://localhost:51206/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51206/tests/kraken/driver.html?testName=ai-astar) 16:03:13 INFO - PID 25179 | RSS: Main: 173981696 16:03:13 INFO - PID 25179 | 16:03:13 INFO - PID 25179 | __start_tp_report 16:03:13 INFO - PID 25179 | _x_x_mozilla_page_load 16:03:13 INFO - PID 25179 | _x_x_mozilla_page_load_details 16:03:13 INFO - PID 25179 | |i|pagename|runs| 16:03:13 INFO - PID 25179 | |0;ai-astar;108;108;107;107;107;108;110;107;108;109 16:03:13 INFO - PID 25179 | |1;audio-beat-detection;119;118;117;116;137;121;126;123;123;147 16:03:13 INFO - PID 25179 | |2;audio-dft;166;165;162;164;161;163;167;168;163;163 16:03:13 INFO - PID 25179 | |3;audio-fft;74;74;75;75;75;75;75;75;74;75 16:03:13 INFO - PID 25179 | |4;audio-oscillator;83;79;85;79;78;79;79;79;78;79 16:03:13 INFO - PID 25179 | |5;imaging-gaussian-blur;111;114;113;113;111;115;114;114;114;117 16:03:13 INFO - PID 25179 | |6;imaging-darkroom;154;148;149;149;150;150;150;148;148;148 16:03:13 INFO - PID 25179 | |7;imaging-desaturate;105;94;94;94;94;94;93;96;94;98 16:03:13 INFO - PID 25179 | |8;json-parse-financial;56;61;53;53;54;54;53;57;55;56 16:03:13 INFO - PID 25179 | |9;json-stringify-tinderbox;39;38;38;38;39;39;39;43;39;39 16:03:13 INFO - PID 25179 | |10;stanford-crypto-aes;79;75;76;75;76;75;80;75;76;76 16:03:13 INFO - PID 25179 | |11;stanford-crypto-ccm;123;117;121;129;132;119;121;118;133;120 16:03:13 INFO - PID 25179 | |12;stanford-crypto-pbkdf2;169;174;173;175;176;173;174;169;170;180 16:03:13 INFO - PID 25179 | |13;stanford-crypto-sha256-iterative;65;71;65;67;64;67;71;65;71;70 16:03:13 INFO - PID 25179 | __end_tp_report 16:03:13 INFO - PID 25179 | __start_cc_report 16:03:13 INFO - PID 25179 | _x_x_mozilla_cycle_collect,945 16:03:13 INFO - PID 25179 | __end_cc_report 16:03:13 INFO - PID 25179 | __startTimestamp1504825393269__endTimestamp 16:03:13 INFO - PID 25179 | 16:03:13 INFO - PID 25179 | ------- Summary: start ------- 16:03:13 INFO - PID 25179 | Number of tests: 14 16:03:13 INFO - PID 25179 | 16:03:13 INFO - PID 25179 | [#0] ai-astar Cycles:10 Average:107.90 Median:108.00 stddev:0.99 (0.9%) stddev-sans-first:1.05 16:03:13 INFO - PID 25179 | Values: 108.0 108.0 107.0 107.0 107.0 108.0 110.0 107.0 108.0 109.0 16:03:13 INFO - PID 25179 | 16:03:13 INFO - PID 25179 | [#1] audio-beat-detection Cycles:10 Average:124.70 Median:123.00 stddev:9.90 (8.0%) stddev-sans-first:10.28 16:03:13 INFO - PID 25179 | Values: 119.0 118.0 117.0 116.0 137.0 121.0 126.0 123.0 123.0 147.0 16:03:13 INFO - PID 25179 | 16:03:13 INFO - PID 25179 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.50 stddev:2.25 (1.4%) stddev-sans-first:2.29 16:03:13 INFO - PID 25179 | Values: 166.0 165.0 162.0 164.0 161.0 163.0 167.0 168.0 163.0 163.0 16:03:13 INFO - PID 25179 | 16:03:13 INFO - PID 25179 | [#3] audio-fft Cycles:10 Average:74.70 Median:75.00 stddev:0.48 (0.6%) stddev-sans-first:0.44 16:03:13 INFO - PID 25179 | Values: 74.0 74.0 75.0 75.0 75.0 75.0 75.0 75.0 74.0 75.0 16:03:13 INFO - PID 25179 | 16:03:13 INFO - PID 25179 | [#4] audio-oscillator Cycles:10 Average:79.80 Median:79.00 stddev:2.30 (2.9%) stddev-sans-first:2.13 16:03:13 INFO - PID 25179 | Values: 83.0 79.0 85.0 79.0 78.0 79.0 79.0 79.0 78.0 79.0 16:03:13 INFO - PID 25179 | 16:03:13 INFO - PID 25179 | [#5] imaging-gaussian-blur Cycles:10 Average:113.60 Median:114.00 stddev:1.78 (1.6%) stddev-sans-first:1.62 16:03:13 INFO - PID 25179 | Values: 111.0 114.0 113.0 113.0 111.0 115.0 114.0 114.0 114.0 117.0 16:03:13 INFO - PID 25179 | 16:03:13 INFO - PID 25179 | [#6] imaging-darkroom Cycles:10 Average:149.40 Median:149.50 stddev:1.84 (1.2%) stddev-sans-first:0.93 16:03:13 INFO - PID 25179 | Values: 154.0 148.0 149.0 149.0 150.0 150.0 150.0 148.0 148.0 148.0 16:03:13 INFO - PID 25179 | 16:03:13 INFO - PID 25179 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:94.00 stddev:3.60 (3.8%) stddev-sans-first:1.51 16:03:13 INFO - PID 25179 | Values: 105.0 94.0 94.0 94.0 94.0 94.0 93.0 96.0 94.0 98.0 16:03:13 INFO - PID 25179 | 16:03:13 INFO - PID 25179 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.50 stddev:2.49 (4.5%) stddev-sans-first:2.62 16:03:13 INFO - PID 25179 | Values: 56.0 61.0 53.0 53.0 54.0 54.0 53.0 57.0 55.0 56.0 16:03:13 INFO - PID 25179 | 16:03:13 INFO - PID 25179 | [#9] json-stringify-tinderbox Cycles:10 Average:39.10 Median:39.00 stddev:1.45 (3.7%) stddev-sans-first:1.54 16:03:13 INFO - PID 25179 | Values: 39.0 38.0 38.0 38.0 39.0 39.0 39.0 43.0 39.0 39.0 16:03:13 INFO - PID 25179 | 16:03:13 INFO - PID 25179 | [#10] stanford-crypto-aes Cycles:10 Average:76.30 Median:76.00 stddev:1.77 (2.3%) stddev-sans-first:1.58 16:03:13 INFO - PID 25179 | Values: 79.0 75.0 76.0 75.0 76.0 75.0 80.0 75.0 76.0 76.0 16:03:13 INFO - PID 25179 | 16:03:13 INFO - PID 25179 | [#11] stanford-crypto-ccm Cycles:10 Average:123.30 Median:122.00 stddev:5.87 (4.8%) stddev-sans-first:6.22 16:03:13 INFO - PID 25179 | Values: 123.0 117.0 121.0 129.0 132.0 119.0 121.0 118.0 133.0 120.0 16:03:13 INFO - PID 25179 | 16:03:13 INFO - PID 25179 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.30 Median:174.00 stddev:3.40 (2.0%) stddev-sans-first:3.23 16:03:13 INFO - PID 25179 | Values: 169.0 174.0 173.0 175.0 176.0 173.0 174.0 169.0 170.0 180.0 16:03:13 INFO - PID 25179 | 16:03:13 INFO - PID 25179 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.50 stddev:2.88 (4.2%) stddev-sans-first:2.89 16:03:13 INFO - PID 25179 | Values: 65.0 71.0 65.0 67.0 64.0 67.0 71.0 65.0 71.0 70.0 16:03:13 INFO - PID 25179 | -------- Summary: end -------- 16:03:13 INFO - PID 25179 | 16:03:13 INFO - PID 25179 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:03:13 INFO - TEST-INFO | 25179: exit 0 16:03:14 INFO - TEST-OK | kraken | took 61689ms 16:03:14 INFO - SUITE-END | took 1172s 16:03:14 INFO - Completed test suite (00:19:32) 16:03:14 INFO - javascript benchmark 16:03:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8650.271781352554, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3068.861901214445, 3076.6923307669235, 3127.0462508934793, 3134.0754477429155, 3134.169445097048, 6077.392260773931, 6238.6256824590555, 6290.087937249096, 6325.746970121189, 6332.303446620868, 6191.628502289855, 6218.347073557268, 6241.563090583661, 6248.15649887265, 6256.968715156429, 5753.108268218432, 5783.566232532556, 5875.618084824473, 5877.441643043925, 5886.558508111887, 5826.359100498963, 5852.564387595292, 5868.530517558585, 5917.112433135043, 5941.019731744257, 5543.861403464925, 5644.463775941279, 5814.592978491507, 5843.357230704619, 5938.792142275021, 5738.483536481736, 5750.712464376765, 5830.0380437227805, 5836.5622578306375, 5841.474267315962, 5617.045102332613, 5732.254806875121, 5754.597178197486, 5809.506191973687, 5812.534997200214, 6086.2087928569, 6092.939070609282, 6148.723307451175, 6153.0, 6163.753449862, 6594.07682924391, 6600.537962342638, 6604.273529911706, 6639.568428052161, 6745.763898263586, 6806.693698783517, 6813.250542440328, 6818.2159051709195, 6821.0, 6827.180738311385, 5944.940550594482, 6118.235220597381, 6339.778107766206, 6340.365963403623, 6353.6823158842335, 6781.186257649015, 6792.796216113525, 6800.115984921928, 6820.181578210647, 6837.726490940307, 6477.0, 6482.416582507597, 6484.935150648433, 6497.512686548528, 6504.837379065467, 6693.866122677519, 6752.291009444036, 6769.8646027079185, 6804.183497980175, 6848.452123830081, 6474.546781725328, 6599.274079851212, 6613.86772264552, 6710.563813352116, 6786.524943254023, 6741.056252124707, 6747.359000894907, 6749.156355455568, 6750.3924646782025, 6750.898736518858, 5260.289860868734, 5264.447233040552, 5311.760970756325, 5328.413874473805, 5344.118220493653, 4596.5863072323655, 4626.1441633297945, 4631.490536041033, 4660.7436590987145, 4674.11191873543, 5670.631408958405, 5694.97152514243, 5735.483806457439, 5804.82585522435, 5886.823395298063, 6750.797476075725, 6769.492288078413, 6814.863702725917, 6823.283555226729, 6832.282610325944, 5784.421557844182, 5799.101139323411, 5817.360090390053, 5891.941080589225, 5901.852453688693, 5591.524720398812, 5756.395578464285, 5757.337906140764, 5834.854128646818, 5836.824895253149, 6284.12022316876, 6534.9673251634385, 6608.471322294205, 6644.833879152963, 6662.467002639777, 6709.563878347892, 6720.663966801738, 6775.830604234737, 6783.152105986752, 6802.319768023158, 6473.190851143607, 6496.220453545605, 6567.080608714688, 6574.934250657623, 6581.473482121323, 6455.67721613908, 6563.901541476977, 6635.966820165868, 6712.865742685217, 6723.125993620798, 6744.022116792939, 6837.521373503807, 6863.519553631198, 6874.243833178246, 6875.346842049998, 6360.395762402564, 6541.574797638138, 6545.541812073109, 6618.669066546557, 6642.535022548375, 6365.713542890674, 6383.648899310582, 6390.616563006234, 6391.296957334783, 6399.840003999937, 6341.143945567289, 6350.237971443456, 6412.070249813658, 6509.381608747161, 6535.901961470677, 6521.0, 6591.143151390289, 6644.202695676549, 6688.83277918056, 6695.765648202289, 6145.016797312409, 6231.750729970931, 6369.394907483782, 6373.075903993988, 6468.029795530708], "value": 6111.720412193606, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [834.5159807311755, 864.852974994251, 887.1970866365941, 890.9955450222748, 892.8392889279932, 40542.39186412202, 41139.58860411399, 41361.58638413615, 41446.17107657849, 41528.0, 38362.808185959104, 38394.0, 38420.23159536807, 38460.23079538408, 38714.8064259679, 6905.482088843331, 7012.929870701304, 7020.754273600425, 7053.188883278412, 7053.576785392867, 6949.722011119549, 7040.894386584206, 7045.647717614099, 7046.401055910228, 7096.361327480526, 7082.610456424894, 7086.57480551166, 7097.929020709778, 7104.254053324404, 7109.928900711005, 7606.125295590995, 7816.0, 7875.251851074138, 7876.842463150733, 7881.842363152762, 7681.615919204018, 7761.6119194040075, 7765.495242809256, 7767.572783496906, 7844.0, 37805.432918506245, 37997.62002379968, 38288.80855595732, 38656.22687546234, 38694.419583706265, 3545.0428384336083, 3591.2637909228547, 3591.497190393347, 3592.802395868226, 3594.4608308753636, 32241.1939701507, 32326.19184520406, 32442.026739197863, 32463.51304730431, 32493.51259731106, 5216.26972223889, 5236.842894713165, 5268.367795864482, 5281.63028587999, 5314.548263397616, 180221.0, 181101.9999999987, 181638.0, 181780.0, 184532.0, 45741.0, 46319.53680463152, 46370.53629463662, 46446.374376896645, 46454.30318545225, 49830.50169498331, 49837.0, 49898.501014989386, 49901.0, 49919.0, 15552.455664051704, 15742.291596878167, 15764.76352854708, 15776.526704198663, 15918.363265469252, 13023.283719395335, 13077.738445231233, 13081.803772943413, 13104.934475327753, 13123.475060997644, 13660.385282662304, 13762.931185344009, 13826.239556824472, 13930.164190148624, 13939.512117075854, 5630.60585758993, 5644.8306550803545, 5679.602427830095, 5710.771569137271, 5729.541636669056, 1008.6620981970975, 1019.6431249062769, 1025.6820385680462, 1026.2046913641987, 1038.4392428088747, 22825.657615135788, 22879.7712022881, 22893.0, 23051.423714407272, 23353.182638607566, 1099.0273607856943, 1117.2570240789946, 1122.3882983773863, 1128.2779021426293, 1146.4554336690005, 12291.262524248574, 12291.692707682201, 12530.37348132608, 12562.309073001074, 12595.370231488389, 240640.0, 241650.0, 242272.0, 242662.0, 243088.0, 52648.473515264355, 55599.444005559424, 56066.43933560612, 56573.43426565682, 56626.15060774009, 1413.9363728632236, 1446.6528033271939, 1448.3061505599576, 1451.4194322271176, 1453.9491117811037, 27747.44505109927, 27899.721002789713, 27948.16155515338, 28094.2976425591, 28282.0, 38128.42807357836, 38376.0, 38385.808070959465, 38399.616003840725, 38512.42231366588, 201896.0, 202312.0, 202545.0, 202679.0, 202910.0, 34106.0, 35413.29173416569, 35993.820030899675, 36067.81966090153, 36152.4577131338, 42604.78697606492, 43569.56430435655, 43781.0, 43983.78008109939, 44072.55927440685, 31505.684943150274, 31832.204194895312, 32114.678853211168, 32149.196270093435, 32202.83898580492, 31762.84118579485, 32178.0, 32302.0, 32385.838070809496, 32902.67097328996, 35941.0, 36184.0, 36278.0, 36283.637163628024, 36444.45333320055, 30706.539401909435, 31064.378712425172, 31233.687663123077, 31254.374912502077, 31361.0, 22870.284728645085, 23240.033081897465, 23278.0, 23465.765342346356, 23492.0], "value": 17153.02865822429, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.1989844573038, 568.414533030978, 573.9311282646083, 578.4793685682886, 597.7907732293697, 21938.89030554847, 22622.43443913903, 22711.31866044017, 22815.0, 22888.31335059951, 24472.388190295253, 24787.380315492075, 24929.87535062322, 26164.86917565414, 26367.20898373047, 6721.764738234163, 6873.381395674388, 6876.931230687679, 6878.037074809531, 6880.2775708550635, 6314.084457753623, 6583.868322633544, 6662.067310576524, 6711.395974362306, 6714.865702685944, 6547.869042619169, 6554.836129096763, 6556.409923106919, 6559.63921984293, 6560.0, 6544.869102617969, 6557.836054098638, 6558.540902136852, 6559.770408035696, 6562.048502967067, 6062.363451837582, 6091.878162436727, 6093.0, 6096.908546371808, 6107.4197951194565, 28074.578881316796, 28854.567181492293, 29161.270968225752, 29192.416151676847, 29427.41145177106, 1948.795376485477, 1992.2529051605648, 1993.2624928776302, 1994.3418671838258, 1996.900154992259, 18987.71518427225, 19405.708914366154, 19810.40568782939, 19813.504662383413, 19869.0, 2450.901963921441, 2458.938526536833, 2490.5766019776684, 2503.7120731115974, 2505.987470062656, 117656.0, 123783.381083094, 124892.75107248902, 130553.6944630551, 134438.3278083613, 14903.254837258093, 14948.814331987061, 15092.924535377253, 15247.3901043957, 15466.381344746309, 22799.544009119723, 22812.4296892579, 22818.65772013421, 22819.429514261945, 22820.885895570747, 10174.949125254327, 10188.235882308856, 10303.0, 10345.224108191916, 10416.958304169673, 9633.373830701123, 9691.321607487549, 9737.07497787709, 9775.120239178366, 9844.655437059668, 9148.2681385489, 9154.72535823913, 9303.76740581491, 9354.532273386303, 9445.244380449547, 2687.3953360493733, 2713.552263876478, 2812.4796912570832, 2812.918440354164, 2900.4054168895327, 933.3746389918771, 973.3673112476805, 977.9877826449733, 984.7341217871135, 987.111599560387, 19212.231510739413, 19350.612987740165, 19356.419307420518, 19467.90266048661, 19610.50973725668, 1033.8242498775226, 1035.4512108582464, 1047.4291511126303, 1047.7642530430744, 1051.1958351860833, 12513.74972500545, 13261.66845828862, 13291.867081329063, 13574.04981651275, 13648.931755341358, 440937.0, 453129.0, 483926.0, 488707.0, 492055.0, 112980.43509782398, 116411.0, 118386.40806796083, 118726.0, 119530.8046919537, 1074.382230217628, 1122.2929554380687, 1187.2460987273143, 1218.8781121887919, 1249.2816630437535, 19753.308634197732, 20178.59642807165, 20343.389698309074, 20380.18479260813, 20444.182232710526, 58072.12891806542, 58251.70874145602, 59251.0, 59277.703611481666, 59367.40632593619, 73265.0, 76219.61890190735, 78657.60671196607, 79015.60492197733, 80312.59843700977, 14384.568462946128, 14776.408943642135, 14829.629259268604, 14912.881533884785, 14941.701165976838, 22070.006849691483, 23084.192053278726, 23294.0, 23511.882440587688, 23786.643200352355, 16911.746323804906, 16969.57576060559, 17050.14749262507, 17277.65444691124, 18716.532086697942, 16851.073190974614, 16910.492685219462, 17284.0, 17395.0, 17609.559761006076, 19213.903930480257, 19638.410847674593, 19686.507837304183, 19785.40643780689, 20006.69989950123, 14437.278136093364, 14636.634084147981, 14754.852451475348, 14802.703945920806, 14807.111573305205, 18706.532336691147, 18813.435596931566, 18818.52953676169, 19150.521236969187, 19181.904090479456], "value": 12138.978983472367, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1310.122218113864, 1397.6505873531614, 1412.9222892740895, 1412.9576112716616, 1413.2933533233384, 15714.0, 16163.191840407992, 16183.595410114753, 16198.0, 16203.351865925379, 15858.444954426597, 15940.963837350564, 16009.35962561499, 16013.599660008505, 16014.0, 2738.7124351943057, 2755.1321333779847, 2802.9018984335553, 2809.7892658050628, 2815.985920070397, 2737.5619900815873, 2770.473610014101, 2788.7211278872155, 2791.5533514637664, 2795.343094372821, 2637.9472410551775, 2741.7669498092687, 2866.6130072440164, 2868.3689588290545, 2886.653601567815, 2751.4497100579865, 2776.9028084016963, 2796.8042237043414, 2802.7337402946687, 2807.536756435186, 2607.2308668942705, 2816.774658027353, 2846.8434236117005, 2850.800443968923, 2853.785966052554, 15114.54656360311, 15195.772063419057, 15225.695486090217, 15227.238638068164, 15238.771418428732, 7922.524648521049, 8256.958715206385, 8264.008319001758, 8264.628091735887, 8271.296939760128, 5214.191800270964, 5314.362276526803, 5390.9191362129595, 5439.728013599304, 5443.700596467193, 1729.6367762769833, 1732.1858726398698, 1739.060907110159, 1764.038598963568, 1772.9024903630295, 26489.73510264892, 27125.593116103275, 27201.0, 27245.59131613047, 27309.590356144672, 7218.566885986857, 7359.852802943911, 7365.631718414058, 7485.925140748632, 7546.396288296923, 19771.40685779429, 19907.601847963248, 20080.69878951817, 20096.39710808678, 20123.0, 8043.879341809878, 8257.92646955904, 8263.628136733862, 8270.214329638675, 8291.626876790559, 7234.457415693739, 7386.335229829341, 7455.291747283999, 7483.812904677427, 7489.700411983568, 5393.514583687487, 5571.832845014656, 5590.496855283044, 5629.296337957755, 5635.886542546545, 1741.4514427955153, 1787.705028670255, 1788.4455818696247, 1820.099050969752, 1825.014492174211, 880.5289170293862, 903.7830920579014, 915.1169121797498, 917.4082716647858, 917.8760867282965, 7498.137714162832, 7549.509281896769, 7549.6225188740345, 7563.092428908456, 7599.316061554487, 722.3823630795699, 725.365305357812, 731.5661303844524, 742.6954948471101, 748.6892939430185, 5257.6845389276, 5280.867978300496, 5285.68285902847, 5393.78424863009, 5447.237386765856, 20222.29221977253, 21607.89196054041, 21725.56548869014, 21747.45631359197, 21750.34748957534, 20325.593488130155, 21288.148474061174, 21312.78687213139, 21352.0, 21370.679439808417, 11186.944065279784, 11478.483468243949, 11483.885161148448, 11495.252808567417, 11497.482613282422, 8671.6097775599, 8813.867791982997, 8909.376343655882, 8987.370884038317, 9034.86447703272, 17942.37201697934, 18185.81814181894, 18373.632527349644, 18616.0, 18774.624507510045, 19002.714959275898, 19075.04624768728, 19235.230590776213, 19469.221231150594, 20206.292779753225, 14024.878009759399, 14142.292885355486, 14305.64235894111, 14349.210793406462, 14386.208758517963, 13938.58184254474, 14160.504382346568, 14181.645458863612, 14190.858091418953, 14196.0, 11413.828792567952, 11616.88383116158, 11741.354225517678, 11883.16817822744, 12080.939595301967, 11100.722481938015, 11102.0, 11205.71985700364, 11231.606893758679, 11516.481758321062, 9513.381630194015, 9839.065288797552, 9839.803203936024, 9843.95078024634, 9844.409335439897, 7554.244575542401, 7594.5063570867715, 7606.0, 7723.806904827425, 7728.188540203198, 7766.417518686234, 7786.26030527099, 7792.922070779219, 7885.408594355332, 7885.526868387915], "value": 6842.626245173, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.94552307272687, 506.821639687726, 518.2537146509025, 523.4817530644661, 528.0725352463508, 6107.755689772409, 6187.72155253013, 6197.814065578029, 6235.812925612227, 6250.624962502247, 6114.388561143884, 6124.877502449948, 6128.295246046706, 6130.478909292704, 6143.32423433422, 4840.6369522285795, 4898.828541001057, 4999.625028122887, 5015.84952451427, 5031.4465408805, 5001.8499445016705, 5015.3730783652045, 5017.247412888059, 5052.191649336107, 5076.873078173038, 4904.877378065541, 4906.681065730734, 4955.132851750929, 4960.33035540201, 4968.130577149002, 4882.829100981467, 4887.902241955177, 4962.60299176065, 4984.252362145671, 4984.40187177541, 4428.31361139024, 4496.910061798779, 4499.595036446703, 4526.0, 4527.796249168795, 6070.0, 6105.297890742532, 6112.786052488186, 6194.96902515489, 6211.223597050369, 5623.353314368859, 5696.458836410535, 5700.914486282709, 5703.287089113861, 5729.341125770548, 6481.513886458487, 6554.70503827329, 6577.04632828242, 6606.735730570771, 6620.2195078067325, 4832.444268909086, 4833.444153922309, 4863.562279394836, 4882.707037577757, 4904.803807847682, 6837.435961514432, 6842.897356539655, 6895.931040689629, 6902.171739391255, 6927.792166234971, 4942.827001054946, 4977.950220497749, 4990.303296879006, 5012.749362531858, 5013.298138260647, 4993.827684957056, 5027.120253955543, 5035.79856805731, 5045.596352291808, 5064.898702025939, 5616.85957851057, 5632.0, 5685.744141513642, 5687.175359572839, 5697.57268204878, 6233.597440575834, 6300.21247344082, 6448.355164483608, 6528.934710652833, 6559.770408035696, 1713.9657206856043, 1728.3345911824038, 1734.9937036518788, 1755.8683098767387, 1767.2135899524844, 1191.6127258640977, 1202.4528839378238, 1203.3682316783584, 1215.8844909733562, 1241.1808206583612, 5630.662160270397, 5706.429357064343, 5770.6249093808765, 5778.3354914184565, 5821.679807610622, 6599.241087274929, 6640.302768209365, 6700.932990670129, 6703.413673684556, 6712.42944349726, 5681.659100453903, 5692.886142277214, 5704.3154821421695, 5711.7144142792695, 5780.624259423208, 3525.665061819123, 3551.827896794052, 3558.323918455537, 3566.28674265148, 3572.6070132285427, 6453.741850326029, 6540.574862633914, 6540.803775886636, 6542.1168142300185, 6586.6288136270905, 6868.450523958071, 6868.587884726832, 6895.896561551581, 6907.412869906114, 6917.754804135203, 6458.6770661466735, 6485.513586480938, 6513.902291465632, 6523.217213934358, 6596.340365963557, 6595.769148079794, 6706.865862682816, 6726.764563240263, 6818.761088483129, 6847.1783385994, 6593.769218077345, 6652.966735166293, 6691.1636045494315, 6769.323067693192, 6772.830679233059, 6415.775447859302, 6564.538298138198, 6568.1789776277965, 6626.271110177973, 6637.435817955335, 4862.513748625109, 4929.433115191799, 4940.925886111783, 4943.678660887031, 4974.5771609413605, 6711.463082953254, 6735.326467353421, 6759.898601520883, 6767.458603311625, 6787.083743694736, 6323.3559274588015, 6461.903071454026, 6531.869362612816, 6561.245456772342, 6566.343365663395, 6503.967480162758, 6562.770303039561, 6576.704048317742, 6581.44057755077, 6613.470922326299, 6432.903506447501, 6443.259025212161, 6443.936750436313, 6452.419282264619, 6459.160309159779, 5879.73541190656, 6446.742130314922, 6476.5466417350335, 6565.934340656723, 6627.204735431779, 6312.968435157978, 6316.210473690789, 6342.556021078481, 6357.554971151975, 6411.807645770635], "value": 5043.148855291327, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [921.442527271001, 923.2567782934735, 940.6942743608329, 942.618239612957, 957.7749228931202, 19400.51498712533, 20400.591988160228, 20521.794782052177, 20652.690209646866, 20660.8966955165, 18461.53846153847, 18866.71699924502, 18976.430707078776, 19234.80765192348, 19237.51906202342, 968.5883499512714, 990.5839547390113, 996.4370130876032, 996.7956568903394, 997.2072202598915, 970.6602689058843, 996.7657600463922, 997.7705127820606, 1000.7047920863326, 1006.612454205129, 1043.306201376084, 1060.188955449082, 1063.138857525403, 1067.1782727299974, 1068.1134658233686, 1040.4953597505205, 1049.569676432659, 1052.3896140238644, 1053.483792941461, 1055.641082032109, 765.6018870187471, 771.6141929035482, 774.5430196184278, 774.748206832776, 775.1899265267808, 20291.492712682153, 20703.378898633066, 20849.37451876446, 20926.686099708517, 20928.686069708965, 21756.564868702695, 21807.890960545097, 22199.778002219933, 22214.333569992927, 22222.333330000125, 17195.1402429878, 17307.394241201622, 17366.826331736647, 17440.0, 17485.0, 3651.1419816343137, 3672.081979505124, 3714.3499887519574, 3714.5542534895985, 3814.256220037094, 111390.0, 137275.0, 138306.0, 140272.0, 141485.29257353648, 17347.739783903253, 17351.611871050285, 17897.910510447364, 17907.910460447616, 17942.641147176982, 29779.10662680123, 31911.20221994422, 32226.677733222838, 32267.51598726021, 32427.675723242937, 9093.727188184364, 9307.90692093084, 9329.30030247734, 9343.2525397968, 9357.578908949114, 4390.07808360248, 4464.486584042812, 4464.665150113755, 4469.575390337913, 4470.441194850644, 5365.248865158881, 5449.100898351807, 5452.972735136299, 5503.477169668875, 5524.088525393346, 1082.7401423658423, 1116.9329840209614, 1118.1613789657756, 1127.875933647298, 1128.1989787251143, 675.587891386254, 694.6353164588631, 701.08508396543, 703.1105651351045, 704.2710794327846, 12386.442610082568, 12444.875551244371, 12622.495100195889, 12915.22508649484, 13226.272555009567, 641.3105911145537, 663.5554178700282, 706.251373544045, 713.9286071392924, 732.1214542548962, 6112.235970503687, 6167.814965551041, 6178.969105154445, 6197.752089916353, 6345.587536810092, 120968.39515802365, 121210.0, 124148.37925810313, 124405.0, 125750.371248145, 85760.57119714361, 87234.0, 103098.48450757698, 107578.46210768896, 113147.0, 82674.58662706648, 91376.54311728399, 95506.0, 95780.52109739547, 96760.51619741856, 12437.875621243671, 12861.742765144832, 12898.419571119135, 12967.0, 12981.091323607634, 42394.57605424029, 42664.360034600126, 43005.78497107494, 43497.78251108724, 43678.12643747044, 58234.70882645559, 59088.40911590829, 77045.0, 85596.0, 87256.56371718101, 18997.24011039543, 19234.80765192386, 19449.222031118596, 20151.69772453385, 20195.0, 20328.186872525526, 20364.083616237007, 20387.0, 20764.273250436163, 22327.10691572319, 19173.137208825356, 19762.50593735168, 20836.0, 20971.685424718336, 21072.262470813446, 20137.6979345307, 20165.49586260355, 20201.79798202058, 20482.180712771322, 21264.468388290417, 17681.469555913343, 17808.198631061892, 17896.91051544734, 18053.819461805215, 20541.48646283795, 13847.792283115963, 14056.929715351358, 14095.788563171765, 14191.361388737325, 14304.928475357972, 13059.21644701283, 13787.586372408843, 13992.0, 14196.006279560332, 14526.782098268322], "value": 9539.847588293896, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1444.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 108.0, 107.0, 107.0, 107.0, 108.0, 110.0, 107.0, 108.0, 109.0], "value": 107.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 117.0, 116.0, 137.0, 121.0, 126.0, 123.0, 123.0, 147.0], "value": 124.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 162.0, 164.0, 161.0, 163.0, 167.0, 168.0, 163.0, 163.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 75.0, 75.0, 75.0, 75.0, 75.0, 74.0, 75.0], "value": 74.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 79.0, 85.0, 79.0, 78.0, 79.0, 79.0, 79.0, 78.0, 79.0], "value": 79.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 113.0, 113.0, 111.0, 115.0, 114.0, 114.0, 114.0, 117.0], "value": 113.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 148.0, 149.0, 149.0, 150.0, 150.0, 150.0, 148.0, 148.0, 148.0], "value": 149.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 96.0, 94.0, 98.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 61.0, 53.0, 53.0, 54.0, 54.0, 53.0, 57.0, 55.0, 56.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 38.0, 38.0, 38.0, 39.0, 39.0, 39.0, 43.0, 39.0, 39.0], "value": 39.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 75.0, 76.0, 75.0, 76.0, 75.0, 80.0, 75.0, 76.0, 76.0], "value": 76.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 117.0, 121.0, 129.0, 132.0, 119.0, 121.0, 118.0, 133.0, 120.0], "value": 123.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 174.0, 173.0, 175.0, 176.0, 173.0, 174.0, 169.0, 170.0, 180.0], "value": 173.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 71.0, 65.0, 67.0, 64.0, 67.0, 71.0, 65.0, 71.0, 70.0], "value": 67.6, "unit": "score"}]}]} 16:03:14 INFO - Return code: 0 16:03:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:03:14 INFO - # TBPL SUCCESS # 16:03:14 INFO - Running post-action listener: _package_coverage_data 16:03:14 INFO - Running post-action listener: _resource_record_post_action 16:03:14 INFO - [mozharness: 2017-09-07 23:03:14.518437Z] Finished run-tests step (success) 16:03:14 INFO - Running post-run listener: _resource_record_post_run 16:03:14 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 393609216; Read time: 20; Write time: 683072 16:03:14 INFO - TinderboxPrint: CPU usage
13.2% 16:03:14 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 16:03:14 INFO - TinderboxPrint: I/O write bytes / time
393,609,216 / 683,072 16:03:14 INFO - TinderboxPrint: CPU idle
8,243.8 (86.8%) 16:03:14 INFO - TinderboxPrint: CPU user
1,193.3 (12.6%) 16:03:14 INFO - TinderboxPrint: Swap in / out
0 / 0 16:03:14 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 108769280; Read time: 0; Write time: 282132 16:03:14 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:03:14 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 284839936; Read time: 0; Write time: 400940 16:03:15 INFO - Running post-run listener: _upload_blobber_files 16:03:15 INFO - Blob upload gear active. 16:03:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:03:15 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 16:03:15 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'] 16:03:15 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 16:03:15 INFO - (blobuploader) - INFO - Open directory for files ... 16:03:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:03:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:03:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:03:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:03:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:03:22 INFO - (blobuploader) - INFO - Done attempting. 16:03:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 16:03:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:03:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:03:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 16:03:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:03:23 INFO - (blobuploader) - INFO - Done attempting. 16:03:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:03:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:03:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:03:24 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:03:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:03:24 INFO - (blobuploader) - INFO - Done attempting. 16:03:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 16:03:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:03:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:03:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 16:03:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:03:25 INFO - (blobuploader) - INFO - Done attempting. 16:03:25 INFO - (blobuploader) - INFO - Iteration through files over. 16:03:25 INFO - Return code: 0 16:03:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:03:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:03:25 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/07799a7c5c07816ee288cf64d2ab4eaae87d47dd8a26515410c095f9f78232d08c043dd4a9686d5634976d3b5b8349d6d9bbf8a7df5f281bf96f3d273495de63", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/deef085fad6b57ee816e3baf99229438abff9061ec7fbce2a89da25066f2e3d1691708bc624fa94d5a281bc8926338e66f646f749ad1af0c4ebca008bafa860c", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a83a84facb511eb38a52c40f1024687d81346edf1b0bdbd6e68b96019036a4455d4d130e569f1da9a958f8e0e6222728d7e6a1a86b890db73b2d0498a2d7fc47", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b198387a3a30dd7cd3f651da754a9406badbca22082fa0a9d348a51be4aea8caeb04575080c59ed12637cb678c098441fed980120bfe5abf86b6b8173565de9"} 16:03:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:03:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:03:25 INFO - Contents: 16:03:25 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/07799a7c5c07816ee288cf64d2ab4eaae87d47dd8a26515410c095f9f78232d08c043dd4a9686d5634976d3b5b8349d6d9bbf8a7df5f281bf96f3d273495de63", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/deef085fad6b57ee816e3baf99229438abff9061ec7fbce2a89da25066f2e3d1691708bc624fa94d5a281bc8926338e66f646f749ad1af0c4ebca008bafa860c", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a83a84facb511eb38a52c40f1024687d81346edf1b0bdbd6e68b96019036a4455d4d130e569f1da9a958f8e0e6222728d7e6a1a86b890db73b2d0498a2d7fc47", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b198387a3a30dd7cd3f651da754a9406badbca22082fa0a9d348a51be4aea8caeb04575080c59ed12637cb678c098441fed980120bfe5abf86b6b8173565de9"} 16:03:25 INFO - Running post-run listener: copy_logs_to_upload_dir 16:03:25 INFO - Copying logs to upload dir... 16:03:25 INFO - mkdir: /builds/slave/test/build/upload/logs 16:03:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.855573 ========= master_lag: -0.21 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-09-07 16:03:25.466639) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-07 16:03:25.471635) ========= 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=af724c981e2a0f424dbabf99000001e7-1504824148.52930-1787114130 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/07799a7c5c07816ee288cf64d2ab4eaae87d47dd8a26515410c095f9f78232d08c043dd4a9686d5634976d3b5b8349d6d9bbf8a7df5f281bf96f3d273495de63", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/deef085fad6b57ee816e3baf99229438abff9061ec7fbce2a89da25066f2e3d1691708bc624fa94d5a281bc8926338e66f646f749ad1af0c4ebca008bafa860c", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a83a84facb511eb38a52c40f1024687d81346edf1b0bdbd6e68b96019036a4455d4d130e569f1da9a958f8e0e6222728d7e6a1a86b890db73b2d0498a2d7fc47", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b198387a3a30dd7cd3f651da754a9406badbca22082fa0a9d348a51be4aea8caeb04575080c59ed12637cb678c098441fed980120bfe5abf86b6b8173565de9"} build_url:https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011422 build_url: 'https://queue.taskcluster.net/v1/task/HU_acp97TAesHcVo7pnBow/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/07799a7c5c07816ee288cf64d2ab4eaae87d47dd8a26515410c095f9f78232d08c043dd4a9686d5634976d3b5b8349d6d9bbf8a7df5f281bf96f3d273495de63", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/deef085fad6b57ee816e3baf99229438abff9061ec7fbce2a89da25066f2e3d1691708bc624fa94d5a281bc8926338e66f646f749ad1af0c4ebca008bafa860c", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a83a84facb511eb38a52c40f1024687d81346edf1b0bdbd6e68b96019036a4455d4d130e569f1da9a958f8e0e6222728d7e6a1a86b890db73b2d0498a2d7fc47", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b198387a3a30dd7cd3f651da754a9406badbca22082fa0a9d348a51be4aea8caeb04575080c59ed12637cb678c098441fed980120bfe5abf86b6b8173565de9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-07 16:03:25.502977) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 16:03:25.503391) ========= 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=af724c981e2a0f424dbabf99000001e7-1504824148.52930-1787114130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004541 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 16:03:25.585345) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-07 16:03:25.585695) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-07 16:03:25.586046) ========= ========= Total master_lag: -0.04 =========