builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-013 starttime: 1506003181.32 results: success (0) revision: f7e9777221a34f9f23c2e4933307eb38b621b679 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-21 07:13:01.323033) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-21 07:13:01.330970) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-21 07:13:01.331328) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-21 07:13:01.373147) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-21 07:13:01.373491) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1506003178.747299-300798062 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-21 07:13:02-- 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% 39.3M=0s 2017-09-21 07:13:02 (39.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.160967 ========= master_lag: 1.35 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-21 07:13:02.887905) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 07:13:02.888322) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1506003178.747299-300798062 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017430 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 07:13:02.927446) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 29 secs) (at 2017-09-21 07:13:02.927799) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f7e9777221a34f9f23c2e4933307eb38b621b679 --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 f7e9777221a34f9f23c2e4933307eb38b621b679 --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=9c3a94c35cc88655b05d2c08000001b2-1506003178.747299-300798062 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-21 07:13:03,647 truncating revision to first 12 chars 2017-09-21 07:13:03,647 Setting DEBUG logging. 2017-09-21 07:13:03,647 attempt 1/10 2017-09-21 07:13:03,647 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f7e9777221a3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-21 07:13:04,786 attempt 1/10 2017-09-21 07:13:05,318 current task status: no status available at this point. state: PENDING 2017-09-21 07:13:05,319 sleeping for 10.00s (attempt 1/10) 2017-09-21 07:13:15,329 attempt 2/10 2017-09-21 07:13:15,840 current task status: no status available at this point. state: PENDING 2017-09-21 07:13:15,840 sleeping for 16.00s (attempt 2/10) 2017-09-21 07:13:31,857 attempt 3/10 2017-09-21 07:13:32,341 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-09-21 07:13:32,551 unpacking tar archive at: mozilla-central-f7e9777221a3/testing/mozharness/ program finished with exit code 0 elapsedTime=29.201945 ========= master_lag: 0.35 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 29 secs) (at 2017-09-21 07:13:32.480496) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-21 07:13:32.480871) ========= script_repo_revision: f7e9777221a34f9f23c2e4933307eb38b621b679 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-21 07:13:32.481278) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-21 07:13:32.481608) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-21 07:13:32.498840) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-21 07:13:32.499218) ========= /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=9c3a94c35cc88655b05d2c08000001b2-1506003178.747299-300798062 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:13:33 INFO - MultiFileLogger online at 20170921 07:13:33 in /builds/slave/test 07:13:33 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 07:13:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:13:33 INFO - {'append_to_log': False, 07:13:33 INFO - 'base_work_dir': '/builds/slave/test', 07:13:33 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:13:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:13:33 INFO - 'branch': 'Firefox-Non-PGO', 07:13:33 INFO - 'buildbot_json_path': 'buildprops.json', 07:13:33 INFO - 'code_coverage': False, 07:13:33 INFO - 'config_files': ('talos/linux_config.py',), 07:13:33 INFO - 'default_actions': ('clobber', 07:13:33 INFO - 'read-buildbot-config', 07:13:33 INFO - 'download-and-extract', 07:13:33 INFO - 'populate-webroot', 07:13:33 INFO - 'create-virtualenv', 07:13:33 INFO - 'install', 07:13:33 INFO - 'setup-mitmproxy', 07:13:33 INFO - 'run-tests'), 07:13:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:13:33 INFO - 'disable_ccov_upload': False, 07:13:33 INFO - 'disable_stylo': False, 07:13:33 INFO - 'download_minidump_stackwalk': True, 07:13:33 INFO - 'download_symbols': 'ondemand', 07:13:33 INFO - 'enable_stylo': False, 07:13:33 INFO - 'enable_webrender': False, 07:13:33 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 07:13:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:13:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:13:33 INFO - 'gecko_profile': False, 07:13:33 INFO - 'gecko_profile_interval': 0, 07:13:33 INFO - 'installer_path': 'installer.exe', 07:13:33 INFO - 'log_level': 'info', 07:13:33 INFO - 'log_name': 'talos', 07:13:33 INFO - 'log_to_console': True, 07:13:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:13:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:13:33 INFO - 'opt_config_files': (), 07:13:33 INFO - 'pip_index': False, 07:13:33 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 07:13:33 INFO - 'system_bits': '32', 07:13:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:13:33 INFO - 'title': 'talos-linux64-ix-013', 07:13:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:13:33 INFO - 'use_talos_json': True, 07:13:33 INFO - 'verify': 'False', 07:13:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:13:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:13:33 INFO - 'work_dir': 'build'} 07:13:33 INFO - [mozharness: 2017-09-21 14:13:33.356059Z] Running clobber step. 07:13:33 INFO - Running pre-action listener: _resource_record_pre_action 07:13:33 INFO - Running main action method: clobber 07:13:33 INFO - rmtree: /builds/slave/test/build 07:13:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:13:34 INFO - Running post-action listener: _resource_record_post_action 07:13:34 INFO - [mozharness: 2017-09-21 14:13:34.855390Z] Finished clobber step (success) 07:13:34 INFO - [mozharness: 2017-09-21 14:13:34.855487Z] Running read-buildbot-config step. 07:13:34 INFO - Running pre-action listener: _resource_record_pre_action 07:13:34 INFO - Running main action method: read_buildbot_config 07:13:34 INFO - Using buildbot properties: 07:13:34 INFO - { 07:13:34 INFO - "project": "", 07:13:34 INFO - "product": "firefox", 07:13:34 INFO - "who": "archaeopteryx@coole-files.de", 07:13:34 INFO - "installer_path": "public/build/target.tar.bz2", 07:13:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 07:13:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 07:13:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 07:13:34 INFO - "stage_platform": "linux64", 07:13:34 INFO - "basedir": "/builds/slave/test", 07:13:34 INFO - "buildnumber": 54, 07:13:34 INFO - "platform": "ubuntu64_hw", 07:13:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:13:34 INFO - "slavebuilddir": "test", 07:13:34 INFO - "taskId": "f00rm5jmShmxXhhzoT8ZMA", 07:13:34 INFO - "branch": "mozilla-central", 07:13:34 INFO - "script_repo_revision": "production", 07:13:34 INFO - "revision": "f7e9777221a34f9f23c2e4933307eb38b621b679", 07:13:34 INFO - "slavename": "talos-linux64-ix-013", 07:13:34 INFO - "repo_path": "mozilla-central" 07:13:34 INFO - } 07:13:34 INFO - Finding installer, test and symbols from parent task. 07:13:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f00rm5jmShmxXhhzoT8ZMA'}, attempt #1 07:13:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f00rm5jmShmxXhhzoT8ZMA'}, attempt #1 07:13:35 INFO - Task dependencies: OYLYgPYVTVKEo2gH9bptQA 07:13:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OYLYgPYVTVKEo2gH9bptQA'}, attempt #1 07:13:36 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/OYLYgPYVTVKEo2gH9bptQA/artifacts/public/build/target.tar.bz2 07:13:36 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/OYLYgPYVTVKEo2gH9bptQA/artifacts/public/build/target.test_packages.json 07:13:36 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/OYLYgPYVTVKEo2gH9bptQA/artifacts/public/build/target.crashreporter-symbols.zip 07:13:36 INFO - Running post-action listener: _resource_record_post_action 07:13:36 INFO - [mozharness: 2017-09-21 14:13:36.267057Z] Finished read-buildbot-config step (success) 07:13:36 INFO - [mozharness: 2017-09-21 14:13:36.267277Z] Running download-and-extract step. 07:13:36 INFO - Running pre-action listener: _resource_record_pre_action 07:13:36 INFO - Running main action method: download_and_extract 07:13:36 INFO - mkdir: /builds/slave/test/build/tests 07:13:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:13:36 INFO - trying https://queue.taskcluster.net/v1/task/OYLYgPYVTVKEo2gH9bptQA/artifacts/public/build/target.test_packages.json 07:13:36 INFO - Downloading https://queue.taskcluster.net/v1/task/OYLYgPYVTVKEo2gH9bptQA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:13:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OYLYgPYVTVKEo2gH9bptQA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:13:36 INFO - Downloaded 989 bytes. 07:13:36 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:13:36 INFO - Using the following test package requirements: 07:13:36 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 07:13:36 INFO - u'common': [u'target.common.tests.zip'], 07:13:36 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:13:36 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:13:36 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:13:36 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:13:36 INFO - u'mozbase': [u'target.common.tests.zip'], 07:13:36 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:13:36 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:13:36 INFO - u'web-platform': [u'target.common.tests.zip', 07:13:36 INFO - u'target.web-platform.tests.tar.gz'], 07:13:36 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:13:36 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 07:13:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OYLYgPYVTVKEo2gH9bptQA/artifacts/public/build/target.common.tests.zip 07:13:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OYLYgPYVTVKEo2gH9bptQA/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:13:36 INFO - Fetch https://queue.taskcluster.net/v1/task/OYLYgPYVTVKEo2gH9bptQA/artifacts/public/build/target.common.tests.zip into memory 07:13:38 INFO - Content-Length response header: 54741111 07:13:38 INFO - Bytes received: 54741111 07:13:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OYLYgPYVTVKEo2gH9bptQA/artifacts/public/build/target.talos.tests.zip 07:13:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OYLYgPYVTVKEo2gH9bptQA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:13:49 INFO - Fetch https://queue.taskcluster.net/v1/task/OYLYgPYVTVKEo2gH9bptQA/artifacts/public/build/target.talos.tests.zip into memory 07:13:50 INFO - Content-Length response header: 14509184 07:13:50 INFO - Bytes received: 14509184 07:13:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:13:51 INFO - trying https://queue.taskcluster.net/v1/task/OYLYgPYVTVKEo2gH9bptQA/artifacts/public/build/target.tar.bz2 07:13:51 INFO - Downloading https://queue.taskcluster.net/v1/task/OYLYgPYVTVKEo2gH9bptQA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:13:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OYLYgPYVTVKEo2gH9bptQA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:13:53 INFO - Downloaded 61718892 bytes. 07:13:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OYLYgPYVTVKEo2gH9bptQA/artifacts/public/build/target.tar.bz2 07:13:53 INFO - mkdir: /builds/slave/test/properties 07:13:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:13:53 INFO - Writing to file /builds/slave/test/properties/build_url 07:13:53 INFO - Contents: 07:13:53 INFO - build_url:https://queue.taskcluster.net/v1/task/OYLYgPYVTVKEo2gH9bptQA/artifacts/public/build/target.tar.bz2 07:13:53 INFO - Running post-action listener: _resource_record_post_action 07:13:53 INFO - Running post-action listener: find_tests_for_verification 07:13:53 INFO - Running post-action listener: set_extra_try_arguments 07:13:53 INFO - [mozharness: 2017-09-21 14:13:53.635843Z] Finished download-and-extract step (success) 07:13:53 INFO - [mozharness: 2017-09-21 14:13:53.635962Z] Running populate-webroot step. 07:13:53 INFO - Running pre-action listener: _resource_record_pre_action 07:13:53 INFO - Running main action method: populate_webroot 07:13:53 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:13:53 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:13:53 INFO - 'tests': ['tresize', 07:13:53 INFO - 'tcanvasmark']}, 07:13:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:13:53 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:13:53 INFO - 'tests': ['dromaeo_css', 07:13:53 INFO - 'kraken']}, 07:13:53 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:13:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:13:53 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:13:53 INFO - 'talos_options': ['--disable-stylo'], 07:13:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:13:53 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:13:53 INFO - 'tests': ['damp', 'tps']}, 07:13:53 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:13:53 INFO - 'talos_options': ['--disable-stylo'], 07:13:53 INFO - 'tests': ['damp', 'tps']}, 07:13:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:13:53 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:13:53 INFO - 'tests': ['dromaeo_dom']}, 07:13:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 07:13:53 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:13:53 INFO - 'tests': ['basic_compositor_video', 07:13:53 INFO - 'glvideo']}, 07:13:53 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 07:13:53 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 07:13:53 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:13:53 INFO - 'talos_options': ['--disable-stylo'], 07:13:53 INFO - 'tests': ['ts_paint_webext', 07:13:53 INFO - 'tp5o_webext']}, 07:13:53 INFO - 'other-e10s': {'tests': ['a11yr', 07:13:53 INFO - 'ts_paint', 07:13:53 INFO - 'tpaint', 07:13:53 INFO - 'sessionrestore', 07:13:53 INFO - 'sessionrestore_many_windows', 07:13:53 INFO - 'sessionrestore_no_auto_restore', 07:13:53 INFO - 'tabpaint']}, 07:13:53 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:13:53 INFO - 'tests': ['a11yr', 07:13:53 INFO - 'ts_paint', 07:13:53 INFO - 'tpaint', 07:13:53 INFO - 'sessionrestore', 07:13:53 INFO - 'sessionrestore_many_windows', 07:13:53 INFO - 'sessionrestore_no_auto_restore', 07:13:53 INFO - 'tabpaint']}, 07:13:53 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 07:13:53 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 07:13:53 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:13:53 INFO - 'tests': ['perf_reftest_singletons']}, 07:13:53 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:13:53 INFO - 'tests': ['bloom_basic']}, 07:13:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:13:53 INFO - 'tsvgr_opacity', 07:13:53 INFO - 'tart', 07:13:53 INFO - 'tscrollx', 07:13:53 INFO - 'tsvg_static']}, 07:13:53 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:13:53 INFO - 'tests': ['tsvgx', 07:13:53 INFO - 'tsvgr_opacity', 07:13:53 INFO - 'tart', 07:13:53 INFO - 'tscrollx', 07:13:53 INFO - 'tsvg_static']}, 07:13:53 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:13:53 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:13:53 INFO - 'talos_options': ['--disable-stylo'], 07:13:53 INFO - 'tests': ['tp5o']}, 07:13:53 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:13:53 INFO - 'talos_options': ['--mitmproxy', 07:13:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:13:53 INFO - '--firstNonBlankPaint'], 07:13:53 INFO - 'tests': ['tp6_google', 07:13:53 INFO - 'tp6_youtube', 07:13:53 INFO - 'tp6_amazon', 07:13:53 INFO - 'tp6_facebook']}, 07:13:53 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:13:53 INFO - 'talos_options': ['--disable-stylo', 07:13:53 INFO - '--mitmproxy', 07:13:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:13:53 INFO - '--firstNonBlankPaint'], 07:13:53 INFO - 'tests': ['tp6_google', 07:13:53 INFO - 'tp6_youtube', 07:13:53 INFO - 'tp6_amazon', 07:13:53 INFO - 'tp6_facebook']}, 07:13:53 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:13:53 INFO - 'talos_options': ['--stylo-threads=1', 07:13:53 INFO - '--mitmproxy', 07:13:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:13:53 INFO - '--firstNonBlankPaint'], 07:13:53 INFO - 'tests': ['tp6_google', 07:13:53 INFO - 'tp6_youtube', 07:13:53 INFO - 'tp6_amazon', 07:13:53 INFO - 'tp6_facebook']}, 07:13:53 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:13:53 INFO - 'talos_options': ['--xperf_path', 07:13:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:13:53 INFO - 'tests': ['tp5n']}, 07:13:53 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:13:53 INFO - 'talos_options': ['--disable-stylo', 07:13:53 INFO - '--xperf_path', 07:13:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:13:53 INFO - 'tests': ['tp5n']}}} 07:13:53 INFO - Running post-action listener: _resource_record_post_action 07:13:53 INFO - [mozharness: 2017-09-21 14:13:53.656284Z] Finished populate-webroot step (success) 07:13:53 INFO - [mozharness: 2017-09-21 14:13:53.656372Z] Running create-virtualenv step. 07:13:53 INFO - Running pre-action listener: _resource_record_pre_action 07:13:53 INFO - Running main action method: create_virtualenv 07:13:53 INFO - Creating virtualenv /builds/slave/test/build/venv 07:13:53 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:13:53 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 07:13:53 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 07:13:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:13:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:13:54 INFO - Installing distribute.............................................................................................................................................................................................done. 07:13:54 INFO - Installing pip...............done. 07:13:54 INFO - Return code: 0 07:13:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:13:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:13:54 INFO - Reading from file tmpfile_stdout 07:13:54 INFO - Output received: 07:13:54 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 07:13:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:13:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:13:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:54 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 0xae21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcaba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe52090>, '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 0xe52d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4cf90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1506003178.747299-300798062', '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 07:13:54 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 07:13:54 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 07:13:54 INFO - Using env: {'DISPLAY': ':0', 07:13:54 INFO - 'HOME': '/home/cltbld', 07:13:54 INFO - 'LANG': 'en_US.UTF-8', 07:13:54 INFO - 'LANGUAGE': 'en_US:en', 07:13:54 INFO - 'LOGNAME': 'cltbld', 07:13:54 INFO - 'MAIL': '/var/mail/cltbld', 07:13:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:54 INFO - 'MOZ_NO_REMOTE': '1', 07:13:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:54 INFO - 'NO_EM_RESTART': '1', 07:13:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:54 INFO - 'PWD': '/builds/slave/test', 07:13:54 INFO - 'SHELL': '/bin/bash', 07:13:54 INFO - 'SHLVL': '1', 07:13:54 INFO - 'TERM': 'linux', 07:13:54 INFO - 'TMOUT': '86400', 07:13:54 INFO - 'USER': 'cltbld', 07:13:54 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506003178.747299-300798062', 07:13:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:54 INFO - '_': '/tools/buildbot/bin/python'} 07:13:55 INFO - Ignoring indexes: http://pypi.python.org/simple/ 07:13:55 INFO - Downloading/unpacking pip>=1.5 07:13:55 INFO - Running setup.py egg_info for package pip 07:13:55 INFO - warning: no files found matching 'pip/cacert.pem' 07:13:55 INFO - warning: no files found matching '*.html' under directory 'docs' 07:13:55 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 07:13:55 INFO - no previously-included directories found matching 'docs/_build/_sources' 07:13:55 INFO - Installing collected packages: pip 07:13:55 INFO - Found existing installation: pip 1.1 07:13:55 INFO - Uninstalling pip: 07:13:55 INFO - Successfully uninstalled pip 07:13:55 INFO - Running setup.py install for pip 07:13:55 INFO - warning: no files found matching 'pip/cacert.pem' 07:13:55 INFO - warning: no files found matching '*.html' under directory 'docs' 07:13:55 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 07:13:55 INFO - no previously-included directories found matching 'docs/_build/_sources' 07:13:55 INFO - Installing pip script to /builds/slave/test/build/venv/bin 07:13:55 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 07:13:55 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 07:13:55 INFO - Successfully installed pip 07:13:55 INFO - Cleaning up... 07:13:55 INFO - Return code: 0 07:13:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:13:55 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')]} 07:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:55 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')]} 07:13:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:55 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 0xae21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcaba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe52090>, '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 0xe52d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4cf90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1506003178.747299-300798062', '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 07:13:55 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 07:13:55 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 07:13:55 INFO - Using env: {'DISPLAY': ':0', 07:13:55 INFO - 'HOME': '/home/cltbld', 07:13:55 INFO - 'LANG': 'en_US.UTF-8', 07:13:55 INFO - 'LANGUAGE': 'en_US:en', 07:13:55 INFO - 'LOGNAME': 'cltbld', 07:13:55 INFO - 'MAIL': '/var/mail/cltbld', 07:13:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:55 INFO - 'MOZ_NO_REMOTE': '1', 07:13:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:55 INFO - 'NO_EM_RESTART': '1', 07:13:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:55 INFO - 'PWD': '/builds/slave/test', 07:13:55 INFO - 'SHELL': '/bin/bash', 07:13:55 INFO - 'SHLVL': '1', 07:13:55 INFO - 'TERM': 'linux', 07:13:55 INFO - 'TMOUT': '86400', 07:13:55 INFO - 'USER': 'cltbld', 07:13:55 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506003178.747299-300798062', 07:13:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:55 INFO - '_': '/tools/buildbot/bin/python'} 07:13:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:56 INFO - Downloading/unpacking psutil>=3.1.1 07:13:56 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 07:13:56 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 07:13:56 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 07:13:56 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 07:13:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:13:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:13:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:13:57 INFO - Installing collected packages: psutil 07:13:57 INFO - Running setup.py install for psutil 07:13:57 INFO - building 'psutil._psutil_linux' extension 07:13:57 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 07:13:57 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 07:13:57 INFO - building 'psutil._psutil_posix' extension 07:13:57 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 07:13:57 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 07:13:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:13:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:13:57 INFO - Successfully installed psutil 07:13:57 INFO - Cleaning up... 07:13:57 INFO - Return code: 0 07:13:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:13:57 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')]} 07:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:57 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')]} 07:13:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:57 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 0xae21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcaba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe52090>, '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 0xe52d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4cf90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1506003178.747299-300798062', '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 07:13:57 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 07:13:57 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 07:13:57 INFO - Using env: {'DISPLAY': ':0', 07:13:57 INFO - 'HOME': '/home/cltbld', 07:13:57 INFO - 'LANG': 'en_US.UTF-8', 07:13:57 INFO - 'LANGUAGE': 'en_US:en', 07:13:57 INFO - 'LOGNAME': 'cltbld', 07:13:57 INFO - 'MAIL': '/var/mail/cltbld', 07:13:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:57 INFO - 'MOZ_NO_REMOTE': '1', 07:13:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:57 INFO - 'NO_EM_RESTART': '1', 07:13:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:57 INFO - 'PWD': '/builds/slave/test', 07:13:57 INFO - 'SHELL': '/bin/bash', 07:13:57 INFO - 'SHLVL': '1', 07:13:57 INFO - 'TERM': 'linux', 07:13:57 INFO - 'TMOUT': '86400', 07:13:57 INFO - 'USER': 'cltbld', 07:13:57 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506003178.747299-300798062', 07:13:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:57 INFO - '_': '/tools/buildbot/bin/python'} 07:13:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:13:58 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 07:13:58 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 07:13:58 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 07:13:58 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 07:13:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:13:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:13:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:13:59 INFO - Installing collected packages: mozsystemmonitor 07:13:59 INFO - Running setup.py install for mozsystemmonitor 07:13:59 INFO - Successfully installed mozsystemmonitor 07:13:59 INFO - Cleaning up... 07:14:00 INFO - Return code: 0 07:14:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:14:00 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')]} 07:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:00 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')]} 07:14:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:00 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 0xae21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcaba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe52090>, '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 0xe52d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4cf90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1506003178.747299-300798062', '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 07:14:00 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 07:14:00 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 07:14:00 INFO - Using env: {'DISPLAY': ':0', 07:14:00 INFO - 'HOME': '/home/cltbld', 07:14:00 INFO - 'LANG': 'en_US.UTF-8', 07:14:00 INFO - 'LANGUAGE': 'en_US:en', 07:14:00 INFO - 'LOGNAME': 'cltbld', 07:14:00 INFO - 'MAIL': '/var/mail/cltbld', 07:14:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:00 INFO - 'MOZ_NO_REMOTE': '1', 07:14:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:00 INFO - 'NO_EM_RESTART': '1', 07:14:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:00 INFO - 'PWD': '/builds/slave/test', 07:14:00 INFO - 'SHELL': '/bin/bash', 07:14:00 INFO - 'SHLVL': '1', 07:14:00 INFO - 'TERM': 'linux', 07:14:00 INFO - 'TMOUT': '86400', 07:14:00 INFO - 'USER': 'cltbld', 07:14:00 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506003178.747299-300798062', 07:14:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:00 INFO - '_': '/tools/buildbot/bin/python'} 07:14:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:00 INFO - Downloading/unpacking jsonschema==2.5.1 07:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:14:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:14:02 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 07:14:02 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 07:14:02 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 07:14:02 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 07:14:02 INFO - Downloading functools32-3.2.3-2.tar.gz 07:14:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:14:02 INFO - warning: no files found matching '*.txt' 07:14:02 INFO - no previously-included directories found matching 'build' 07:14:02 INFO - no previously-included directories found matching 'dist' 07:14:02 INFO - no previously-included directories found matching '.git*' 07:14:03 INFO - Installing collected packages: jsonschema, functools32 07:14:03 INFO - Running setup.py install for functools32 07:14:03 INFO - warning: no files found matching '*.txt' 07:14:03 INFO - no previously-included directories found matching 'build' 07:14:03 INFO - no previously-included directories found matching 'dist' 07:14:03 INFO - no previously-included directories found matching '.git*' 07:14:03 INFO - Successfully installed jsonschema functools32 07:14:03 INFO - Cleaning up... 07:14:03 INFO - Return code: 0 07:14:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:14: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')]} 07:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14: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')]} 07:14:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:03 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 0xae21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcaba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe52090>, '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 0xe52d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4cf90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1506003178.747299-300798062', '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 07:14:03 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 07:14:03 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 07:14:03 INFO - Using env: {'DISPLAY': ':0', 07:14:03 INFO - 'HOME': '/home/cltbld', 07:14:03 INFO - 'LANG': 'en_US.UTF-8', 07:14:03 INFO - 'LANGUAGE': 'en_US:en', 07:14:03 INFO - 'LOGNAME': 'cltbld', 07:14:03 INFO - 'MAIL': '/var/mail/cltbld', 07:14:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:03 INFO - 'MOZ_NO_REMOTE': '1', 07:14:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:03 INFO - 'NO_EM_RESTART': '1', 07:14:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:03 INFO - 'PWD': '/builds/slave/test', 07:14:03 INFO - 'SHELL': '/bin/bash', 07:14:03 INFO - 'SHLVL': '1', 07:14:03 INFO - 'TERM': 'linux', 07:14:03 INFO - 'TMOUT': '86400', 07:14:03 INFO - 'USER': 'cltbld', 07:14:03 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506003178.747299-300798062', 07:14:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:03 INFO - '_': '/tools/buildbot/bin/python'} 07:14:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:14:03 INFO - Cleaning up... 07:14:03 INFO - Return code: 0 07:14:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:14: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')]} 07:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14: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')]} 07:14:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:03 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 0xae21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcaba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe52090>, '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 0xe52d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4cf90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1506003178.747299-300798062', '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 07:14:03 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 07:14:03 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 07:14:03 INFO - Using env: {'DISPLAY': ':0', 07:14:03 INFO - 'HOME': '/home/cltbld', 07:14:03 INFO - 'LANG': 'en_US.UTF-8', 07:14:03 INFO - 'LANGUAGE': 'en_US:en', 07:14:03 INFO - 'LOGNAME': 'cltbld', 07:14:03 INFO - 'MAIL': '/var/mail/cltbld', 07:14:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:03 INFO - 'MOZ_NO_REMOTE': '1', 07:14:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:03 INFO - 'NO_EM_RESTART': '1', 07:14:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:03 INFO - 'PWD': '/builds/slave/test', 07:14:03 INFO - 'SHELL': '/bin/bash', 07:14:03 INFO - 'SHLVL': '1', 07:14:03 INFO - 'TERM': 'linux', 07:14:03 INFO - 'TMOUT': '86400', 07:14:03 INFO - 'USER': 'cltbld', 07:14:03 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506003178.747299-300798062', 07:14:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:03 INFO - '_': '/tools/buildbot/bin/python'} 07:14:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:03 INFO - Downloading/unpacking blobuploader==1.2.4 07:14:03 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 07:14:03 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 07:14:03 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 07:14:03 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 07:14:04 INFO - Downloading blobuploader-1.2.4.tar.gz 07:14:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:14:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:14:04 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 07:14:04 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 07:14:04 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 07:14:04 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 07:14:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:14:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:14:05 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 07:14:05 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 07:14:05 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 07:14:05 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 07:14:05 INFO - Downloading docopt-0.6.1.tar.gz 07:14:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:14:05 INFO - Installing collected packages: blobuploader, requests, docopt 07:14:05 INFO - Running setup.py install for blobuploader 07:14:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:14:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:14:05 INFO - Running setup.py install for requests 07:14:05 INFO - Running setup.py install for docopt 07:14:05 INFO - Successfully installed blobuploader requests docopt 07:14:05 INFO - Cleaning up... 07:14:05 INFO - Return code: 0 07:14:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:14: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')]} 07:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14: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')]} 07:14:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:05 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 0xae21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcaba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe52090>, '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 0xe52d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4cf90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1506003178.747299-300798062', '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 07:14:05 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 07:14:05 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 07:14:05 INFO - Using env: {'DISPLAY': ':0', 07:14:05 INFO - 'HOME': '/home/cltbld', 07:14:05 INFO - 'LANG': 'en_US.UTF-8', 07:14:05 INFO - 'LANGUAGE': 'en_US:en', 07:14:05 INFO - 'LOGNAME': 'cltbld', 07:14:05 INFO - 'MAIL': '/var/mail/cltbld', 07:14:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:05 INFO - 'MOZ_NO_REMOTE': '1', 07:14:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:05 INFO - 'NO_EM_RESTART': '1', 07:14:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:05 INFO - 'PWD': '/builds/slave/test', 07:14:05 INFO - 'SHELL': '/bin/bash', 07:14:05 INFO - 'SHLVL': '1', 07:14:05 INFO - 'TERM': 'linux', 07:14:05 INFO - 'TMOUT': '86400', 07:14:05 INFO - 'USER': 'cltbld', 07:14:05 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506003178.747299-300798062', 07:14:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:05 INFO - '_': '/tools/buildbot/bin/python'} 07:14:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:14:06 INFO - Running setup.py (path:/tmp/pip-X_WZGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:14:06 INFO - Running setup.py (path:/tmp/pip-0fVJA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:14:06 INFO - Running setup.py (path:/tmp/pip-Pyr_Z2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:14:06 INFO - Running setup.py (path:/tmp/pip-BAzpok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:14:06 INFO - Running setup.py (path:/tmp/pip-cSqKJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:14:06 INFO - Running setup.py (path:/tmp/pip-NTxPsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:14:06 INFO - Running setup.py (path:/tmp/pip-XDpFhW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:14:06 INFO - Running setup.py (path:/tmp/pip-BZFwIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:14:06 INFO - Running setup.py (path:/tmp/pip-z_niqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:14:06 INFO - Running setup.py (path:/tmp/pip-6AH7eD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:14:06 INFO - Running setup.py (path:/tmp/pip-xtDdaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:14:06 INFO - Running setup.py (path:/tmp/pip-BoZbKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:14:06 INFO - Running setup.py (path:/tmp/pip-1AuQ36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:14:07 INFO - Running setup.py (path:/tmp/pip-HSwcRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:14:07 INFO - Running setup.py (path:/tmp/pip-P4gjrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:14:07 INFO - Running setup.py (path:/tmp/pip-ZXvver-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:14:07 INFO - Running setup.py (path:/tmp/pip-7r9X2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:14:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:14:07 INFO - Running setup.py install for manifestparser 07:14:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:14:07 INFO - Running setup.py install for mozcrash 07:14:07 INFO - Running setup.py install for mozdebug 07:14:07 INFO - Running setup.py install for mozdevice 07:14:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:14:07 INFO - Running setup.py install for mozfile 07:14:07 INFO - Running setup.py install for mozhttpd 07:14:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:14:07 INFO - Running setup.py install for mozinfo 07:14:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:14:07 INFO - Running setup.py install for mozInstall 07:14:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:14:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:14:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:14:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:14:08 INFO - Running setup.py install for mozleak 07:14:08 INFO - Running setup.py install for mozlog 07:14:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:14:08 INFO - Running setup.py install for moznetwork 07:14:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:14:08 INFO - Running setup.py install for mozprocess 07:14:08 INFO - Running setup.py install for mozprofile 07:14:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:14:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:14:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:14:08 INFO - Running setup.py install for mozrunner 07:14:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:14:08 INFO - Running setup.py install for mozscreenshot 07:14:08 INFO - Running setup.py install for moztest 07:14:08 INFO - Running setup.py install for mozversion 07:14:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:14:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:14:09 INFO - Cleaning up... 07:14:09 INFO - Return code: 0 07:14:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:14: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')]} 07:14:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14: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')]} 07:14:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:09 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 0xae21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcaba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe52090>, '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 0xe52d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4cf90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1506003178.747299-300798062', '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 07:14:09 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 07:14:09 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 07:14:09 INFO - Using env: {'DISPLAY': ':0', 07:14:09 INFO - 'HOME': '/home/cltbld', 07:14:09 INFO - 'LANG': 'en_US.UTF-8', 07:14:09 INFO - 'LANGUAGE': 'en_US:en', 07:14:09 INFO - 'LOGNAME': 'cltbld', 07:14:09 INFO - 'MAIL': '/var/mail/cltbld', 07:14:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:09 INFO - 'MOZ_NO_REMOTE': '1', 07:14:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:09 INFO - 'NO_EM_RESTART': '1', 07:14:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:09 INFO - 'PWD': '/builds/slave/test', 07:14:09 INFO - 'SHELL': '/bin/bash', 07:14:09 INFO - 'SHLVL': '1', 07:14:09 INFO - 'TERM': 'linux', 07:14:09 INFO - 'TMOUT': '86400', 07:14:09 INFO - 'USER': 'cltbld', 07:14:09 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506003178.747299-300798062', 07:14:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:09 INFO - '_': '/tools/buildbot/bin/python'} 07:14:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:14:09 INFO - Running setup.py (path:/tmp/pip-VpMFyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:14:09 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)) 07:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:14:09 INFO - Running setup.py (path:/tmp/pip-gwTCbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:14:09 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)) 07:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:14:09 INFO - Running setup.py (path:/tmp/pip-_pKBFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:14:09 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)) 07:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:14:09 INFO - Running setup.py (path:/tmp/pip-QhIcN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:14:09 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)) 07:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:14:09 INFO - Running setup.py (path:/tmp/pip-HBPt6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:14:09 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)) 07:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:14:09 INFO - Running setup.py (path:/tmp/pip-fXzX7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:14:09 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)) 07:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:14:09 INFO - Running setup.py (path:/tmp/pip-9CpP0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:14:09 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)) 07:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:14:09 INFO - Running setup.py (path:/tmp/pip-wBPzOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:14:09 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)) 07:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:14:09 INFO - Running setup.py (path:/tmp/pip-YS7Yq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:14:09 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)) 07:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:14:09 INFO - Running setup.py (path:/tmp/pip-rjCEn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:14:10 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)) 07:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:14:10 INFO - Running setup.py (path:/tmp/pip-ark5Sp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:14:10 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)) 07:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:14:10 INFO - Running setup.py (path:/tmp/pip-aIB38b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:14:10 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)) 07:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:14:10 INFO - Running setup.py (path:/tmp/pip-_3AFWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:14:10 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)) 07:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:14:10 INFO - Running setup.py (path:/tmp/pip-KkXTQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:14:10 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)) 07:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:14:10 INFO - Running setup.py (path:/tmp/pip-ZIDw5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:14:10 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)) 07:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:14:10 INFO - Running setup.py (path:/tmp/pip-DX_4qY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:14:10 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)) 07:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:14:10 INFO - Running setup.py (path:/tmp/pip-o6CKXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:14:10 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)) 07:14:10 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)) 07:14:10 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)) 07:14:10 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)) 07:14:10 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)) 07:14:10 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)) 07:14:10 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)) 07:14:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:14: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 07:14: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 07:14: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 07:14: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 07:14:11 INFO - Downloading blessings-1.6.tar.gz 07:14:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:14:11 INFO - Installing collected packages: blessings 07:14:11 INFO - Running setup.py install for blessings 07:14:11 INFO - Successfully installed blessings 07:14:11 INFO - Cleaning up... 07:14:11 INFO - Return code: 0 07:14:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:14:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:14:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:14:12 INFO - Reading from file tmpfile_stdout 07:14:12 INFO - Current package versions: 07:14:12 INFO - argparse == 1.2.1 07:14:12 INFO - blessings == 1.6 07:14:12 INFO - blobuploader == 1.2.4 07:14:12 INFO - docopt == 0.6.1 07:14:12 INFO - functools32 == 3.2.3-2 07:14:12 INFO - jsonschema == 2.5.1 07:14:12 INFO - manifestparser == 1.1 07:14:12 INFO - mozInstall == 1.13 07:14:12 INFO - mozcrash == 1.0 07:14:12 INFO - mozdebug == 0.1 07:14:12 INFO - mozdevice == 0.51 07:14:12 INFO - mozfile == 1.2 07:14:12 INFO - mozhttpd == 0.7 07:14:12 INFO - mozinfo == 0.10 07:14:12 INFO - mozleak == 0.1 07:14:12 INFO - mozlog == 3.5 07:14:12 INFO - moznetwork == 0.27 07:14:12 INFO - mozprocess == 0.25 07:14:12 INFO - mozprofile == 0.28 07:14:12 INFO - mozrunner == 6.13 07:14:12 INFO - mozscreenshot == 0.1 07:14:12 INFO - mozsystemmonitor == 0.3 07:14:12 INFO - moztest == 0.8 07:14:12 INFO - mozversion == 1.4 07:14:12 INFO - psutil == 3.1.1 07:14:12 INFO - requests == 1.2.3 07:14:12 INFO - wsgiref == 0.1.2 07:14:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:14:12 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')]} 07:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:12 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')]} 07:14:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:12 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 0xae21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcaba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe52090>, '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 0xe52d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4cf90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1506003178.747299-300798062', '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 07:14:12 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 07:14:12 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 07:14:12 INFO - Using env: {'DISPLAY': ':0', 07:14:12 INFO - 'HOME': '/home/cltbld', 07:14:12 INFO - 'LANG': 'en_US.UTF-8', 07:14:12 INFO - 'LANGUAGE': 'en_US:en', 07:14:12 INFO - 'LOGNAME': 'cltbld', 07:14:12 INFO - 'MAIL': '/var/mail/cltbld', 07:14:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:12 INFO - 'MOZ_NO_REMOTE': '1', 07:14:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:12 INFO - 'NO_EM_RESTART': '1', 07:14:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:12 INFO - 'PWD': '/builds/slave/test', 07:14:12 INFO - 'SHELL': '/bin/bash', 07:14:12 INFO - 'SHLVL': '1', 07:14:12 INFO - 'TERM': 'linux', 07:14:12 INFO - 'TMOUT': '86400', 07:14:12 INFO - 'USER': 'cltbld', 07:14:12 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506003178.747299-300798062', 07:14:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:12 INFO - '_': '/tools/buildbot/bin/python'} 07:14:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:12 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)) 07:14:12 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)) 07:14:12 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)) 07:14:12 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)) 07:14:12 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)) 07:14:12 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)) 07:14:12 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)) 07:14:12 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)) 07:14:12 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)) 07:14:12 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 07:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 07:14:13 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)) 07:14:13 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)) 07:14:13 INFO - Installing collected packages: simplejson 07:14:13 INFO - Running setup.py install for simplejson 07:14:13 INFO - building 'simplejson._speedups' extension 07:14:13 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 07:14:14 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 07:14:14 INFO - Successfully installed simplejson 07:14:14 INFO - Cleaning up... 07:14:14 INFO - Return code: 0 07:14:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:14: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')]} 07:14:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14: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')]} 07:14:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:14 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 0xae21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcaba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe52090>, '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 0xe52d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4cf90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1506003178.747299-300798062', '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 07:14:14 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 07:14:14 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 07:14:14 INFO - Using env: {'DISPLAY': ':0', 07:14:14 INFO - 'HOME': '/home/cltbld', 07:14:14 INFO - 'LANG': 'en_US.UTF-8', 07:14:14 INFO - 'LANGUAGE': 'en_US:en', 07:14:14 INFO - 'LOGNAME': 'cltbld', 07:14:14 INFO - 'MAIL': '/var/mail/cltbld', 07:14:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:14 INFO - 'MOZ_NO_REMOTE': '1', 07:14:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:14 INFO - 'NO_EM_RESTART': '1', 07:14:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:14 INFO - 'PWD': '/builds/slave/test', 07:14:14 INFO - 'SHELL': '/bin/bash', 07:14:14 INFO - 'SHLVL': '1', 07:14:14 INFO - 'TERM': 'linux', 07:14:14 INFO - 'TMOUT': '86400', 07:14:14 INFO - 'USER': 'cltbld', 07:14:14 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506003178.747299-300798062', 07:14:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:14 INFO - '_': '/tools/buildbot/bin/python'} 07:14:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:14:14 INFO - Cleaning up... 07:14:14 INFO - Return code: 0 07:14:14 INFO - Running post-action listener: _resource_record_post_action 07:14:14 INFO - Running post-action listener: _start_resource_monitoring 07:14:14 INFO - Starting resource monitoring. 07:14:14 INFO - [mozharness: 2017-09-21 14:14:14.798854Z] Finished create-virtualenv step (success) 07:14:14 INFO - [mozharness: 2017-09-21 14:14:14.799324Z] Running install step. 07:14:14 INFO - Running pre-action listener: _resource_record_pre_action 07:14:14 INFO - Running main action method: install 07:14:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:14:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:14:15 INFO - Reading from file tmpfile_stdout 07:14:15 INFO - Detecting whether we're running mozinstall >=1.0... 07:14:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:14:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:14:15 INFO - Reading from file tmpfile_stdout 07:14:15 INFO - Output received: 07:14:15 INFO - Usage: mozinstall [options] installer 07:14:15 INFO - Options: 07:14:15 INFO - -h, --help show this help message and exit 07:14:15 INFO - -d DEST, --destination=DEST 07:14:15 INFO - Directory to install application into. [default: 07:14:15 INFO - "/builds/slave/test"] 07:14:15 INFO - --app=APP Application being installed. [default: firefox] 07:14:15 INFO - mkdir: /builds/slave/test/build/application 07:14:15 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'] 07:14:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:14:32 INFO - Reading from file tmpfile_stdout 07:14:32 INFO - Output received: 07:14:32 INFO - /builds/slave/test/build/application/firefox/firefox 07:14:32 INFO - Running post-action listener: _resource_record_post_action 07:14:32 INFO - [mozharness: 2017-09-21 14:14:32.933434Z] Finished install step (success) 07:14:32 INFO - [mozharness: 2017-09-21 14:14:32.933686Z] Running setup-mitmproxy step. 07:14:32 INFO - Running pre-action listener: _resource_record_pre_action 07:14:32 INFO - Running main action method: setup_mitmproxy 07:14:32 INFO - Skipping: mitmproxy is not required 07:14:32 INFO - Running post-action listener: _resource_record_post_action 07:14:32 INFO - [mozharness: 2017-09-21 14:14:32.934885Z] Finished setup-mitmproxy step (success) 07:14:32 INFO - [mozharness: 2017-09-21 14:14:32.935104Z] Running run-tests step. 07:14:32 INFO - Running pre-action listener: _resource_record_pre_action 07:14:32 INFO - Running pre-action listener: _set_gcov_prefix 07:14:32 INFO - Running main action method: run_tests 07:14:32 WARNING - Try message not found. 07:14:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:14:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:14:32 INFO - Python 2.7.3 07:14:32 INFO - Return code: 0 07:14:32 INFO - grabbing minidump binary from tooltool 07:14:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:14:32 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 0xe52090>, '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 0xe52d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4cf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:14:32 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 07:14:32 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 07:14:32 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 07:14:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:14:33 INFO - Return code: 0 07:14:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:14:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:14:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:14:33 INFO - ENV: RUST_BACKTRACE is now full 07:14:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:14:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:14:33 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/OYLYgPYVTVKEo2gH9bptQA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 07:14:33 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/OYLYgPYVTVKEo2gH9bptQA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 07:14:33 INFO - Using env: {'DISPLAY': ':0', 07:14:33 INFO - 'HOME': '/home/cltbld', 07:14:33 INFO - 'LANG': 'en_US.UTF-8', 07:14:33 INFO - 'LANGUAGE': 'en_US:en', 07:14:33 INFO - 'LOGNAME': 'cltbld', 07:14:33 INFO - 'MAIL': '/var/mail/cltbld', 07:14:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:14:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:14:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:33 INFO - 'MOZ_NO_REMOTE': '1', 07:14:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:14:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:33 INFO - 'NO_EM_RESTART': '1', 07:14:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:33 INFO - 'PWD': '/builds/slave/test', 07:14:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:14:33 INFO - 'RUST_BACKTRACE': 'full', 07:14:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:14:33 INFO - 'SHELL': '/bin/bash', 07:14:33 INFO - 'SHLVL': '1', 07:14:33 INFO - 'TERM': 'linux', 07:14:33 INFO - 'TMOUT': '86400', 07:14:33 INFO - 'USER': 'cltbld', 07:14:33 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506003178.747299-300798062', 07:14:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:33 INFO - '_': '/tools/buildbot/bin/python'} 07:14:33 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/OYLYgPYVTVKEo2gH9bptQA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 07:14:33 INFO - mozversion application_buildid: 20170921132403 07:14:33 INFO - mozversion application_changeset: f7e9777221a34f9f23c2e4933307eb38b621b679 07:14:33 INFO - mozversion application_display_name: Nightly 07:14:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:14:33 INFO - mozversion application_name: Firefox 07:14:33 INFO - mozversion application_remotingname: firefox 07:14:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:14:33 INFO - mozversion application_vendor: Mozilla 07:14:33 INFO - mozversion application_version: 57.0a1 07:14:33 INFO - mozversion platform_buildid: 20170921132403 07:14:33 INFO - mozversion platform_changeset: f7e9777221a34f9f23c2e4933307eb38b621b679 07:14:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:14:33 INFO - mozversion platform_version: 57.0a1 07:14:33 INFO - using testdate: 1506003273 07:14:33 INFO - actual date: 1506003273 07:14:33 INFO - starting webserver on 'localhost:50013' 07:14:33 INFO - SUITE-START | Running 2 tests 07:14:33 INFO - TEST-START | dromaeo_css 07:14:33 INFO - Initialising browser for dromaeo_css test... 07:14:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50013/getInfo.html -profile /tmp/tmp6BpEWY/profile 07:14:33 INFO - TEST-INFO | started process 20422 (/builds/slave/test/build/application/firefox/firefox http://localhost:50013/getInfo.html) 07:14:39 INFO - TEST-INFO | 20422: exit 0 07:14:39 INFO - Browser initialized. 07:14:39 INFO - Running cycle 1/1 for dromaeo_css test... 07:14:39 INFO - Using env: {'DISPLAY': ':0', 07:14:39 INFO - 'HOME': '/home/cltbld', 07:14:39 INFO - 'JSGC_DISABLE_POISONING': '1', 07:14:39 INFO - 'LANG': 'en_US.UTF-8', 07:14:39 INFO - 'LANGUAGE': 'en_US:en', 07:14:39 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 07:14:39 INFO - 'LOGNAME': 'cltbld', 07:14:39 INFO - 'MAIL': '/var/mail/cltbld', 07:14:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:14:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:14:39 INFO - 'MOZ_CRASHREPORTER': '1', 07:14:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:39 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 07:14:39 INFO - 'MOZ_NO_REMOTE': '1', 07:14:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:14:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:39 INFO - 'NO_EM_RESTART': '1', 07:14:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:39 INFO - 'PWD': '/builds/slave/test', 07:14:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:14:39 INFO - 'RUST_BACKTRACE': 'full', 07:14:39 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:14:39 INFO - 'SHELL': '/bin/bash', 07:14:39 INFO - 'SHLVL': '1', 07:14:39 INFO - 'STYLO_FORCE_DISABLED': '1', 07:14:39 INFO - 'TERM': 'linux', 07:14:39 INFO - 'TMOUT': '86400', 07:14:39 INFO - 'USER': 'cltbld', 07:14:39 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506003178.747299-300798062', 07:14:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:39 INFO - '_': '/tools/buildbot/bin/python'} 07:14:39 INFO - TEST-INFO | started process 20657 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6BpEWY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:14:40 INFO - PID 20657 | 07:14:40 INFO - PID 20657 | (/builds/slave/test/build/application/firefox/firefox:20707): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:14:40 INFO - PID 20657 | 07:14:50 INFO - PID 20657 | RSS: Main: 150507520 07:14:50 INFO - PID 20657 | 07:17:47 INFO - PID 20657 | Cycle 1(1): loaded http://localhost:50013/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50013/tests/dromaeo/cssquery-ext.html) 07:17:48 INFO - PID 20657 | RSS: Main: 154607616 07:17:48 INFO - PID 20657 | 07:20:50 INFO - PID 20657 | Cycle 1(1): loaded http://localhost:50013/tests/dromaeo/cssquery-ext.html (next: http://localhost:50013/tests/dromaeo/cssquery-jquery.html) 07:20:51 INFO - PID 20657 | RSS: Main: 154329088 07:20:51 INFO - PID 20657 | 07:23:52 INFO - PID 20657 | Cycle 1(1): loaded http://localhost:50013/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50013/tests/dromaeo/cssquery-mootools.html) 07:23:53 INFO - PID 20657 | RSS: Main: 156282880 07:23:53 INFO - PID 20657 | 07:26:55 INFO - PID 20657 | Cycle 1(1): loaded http://localhost:50013/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50013/tests/dromaeo/cssquery-prototype.html) 07:26:55 INFO - PID 20657 | RSS: Main: 155340800 07:26:55 INFO - PID 20657 | 07:29:58 INFO - PID 20657 | Cycle 1(1): loaded http://localhost:50013/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50013/tests/dromaeo/cssquery-yui.html) 07:29:59 INFO - PID 20657 | RSS: Main: 156377088 07:29:59 INFO - PID 20657 | 07:33:01 INFO - PID 20657 | Cycle 1(1): loaded http://localhost:50013/tests/dromaeo/cssquery-yui.html (next: http://localhost:50013/tests/dromaeo/cssquery-dojo.html) 07:33:01 INFO - PID 20657 | RSS: Main: 159248384 07:33:01 INFO - PID 20657 | 07:33:01 INFO - PID 20657 | __start_tp_report 07:33:01 INFO - PID 20657 | _x_x_mozilla_page_load 07:33:01 INFO - PID 20657 | _x_x_mozilla_page_load_details 07:33:01 INFO - PID 20657 | |i|pagename|runs| 07:33:01 INFO - PID 20657 | |0;dojo.html;3164.1614972032407;3181.7613678974067;3182.6499085100622;3192.6328472225687;3201.071689210129;6288.088227207052;6334.8733025339525;6338.968305158479;6446.5165112616505;6507.772227972016;6309.684515774205;6321.336259692735;6362.904556431646;6399.1681081459465;6426.935730642692;5846.298444186693;5847.122931560279;5859.853503662422;5862;5896.204012458306;5852.9707351463185;5872.500837428824;5911.438413350725;5958.433948774881;5985.1022346647915;5888.617239879415;5959.404059594028;5963.9403605964035;5981.1028345748055;6009;5694.9715251423895;5808.099744539603;5880.206172166767;5924.466797988159;5976.940230597682;5302.549283310923;5769.88460230793;5779.248697669318;5912.556558258105;5921.111833225051;6361.872762544724;6401.871962560723;6403;6468.417842394207;6474.967625161891;6648.368405001517;6649.401553860127;6787.626680532569;6832.863342733167;6932.133483314586;6896.586204827727;6907.758228461979;6923.5499692520325;6923.965380173117;6932.757353492654;6398.808035758934;6401.647909364983;6425.710843012076;6445.93554064458;6450.709718062699;6946.479014073965;7033.788986330418;7099.787006389816;7124.643767811589;7137.321954414322;6620.801375958729;6693.464522838161;6751.91969284912;6833.4191593715095;6834.350736680008;6768.69540870662;6780.762673306509;6797.694103765342;6828.760993365208;6845.691943862538;6748.19021717397;6831.146106736658;6873.2783057778215;6877.58734475933;6880.346367095118;6815.148106486689;6825.419839313615;6833.93166068333;6915.930840691629;6923.6884340204815;5257.579393648499;5329.413764485904;5356.400973351522;5361.865953351119;5424.240606315119;4680.625549955996;4738.857834264978;4739.052189562101;4743.762811859462;4755.643326750507;5770.682612456271;5849.912251316234;5855.590108692436;5868.882622347529;5891.440313170242;6755.729770809211;6832;6869.793906182823;6931.098957135641;6952.200496942815;5638.182463542763;5784.161296611967;5797.797077102281;5859.794907178229;5860.619059761102;5854.795082172103;5871.911921321183;5927.051671732502;5934.347221805598;5940.61386009908;6615.404613584704;6624.56940298879;6707.899381509281;6710.698018589078;6712.664366781739;6574.408303252731;6809.319068093151;6811.012403201409;6811.795646130624;6812.93187068123;6511.413972742476;6516.609003459807;6516.837079072871;6517.315681853337;6558.704858281293;6671.39957403836;6739.898901516579;6831.11195544576;6831.795046148623;6837.62393068386;6873.793786186422;6877.071595334566;6963.8607227854145;6972.51192416526;6977.058097156819;6606.768763093461;6611.338866113542;6697;6706.765263215764;6720.966395167993;6486.091947127312;6578.440832529289;6578.506612004215;6598.439132673777;6702.229243637044;6526.869462610816;6541.6402097885075;6544.312847150981;6548.116004339353;6553.705083271169;6650.800475985729;6672.633005184762;6751.088603038527;6767.424768894502;6824.863502730017;6490.123833282447;6494.935050649433;6565.146530950946;6565.310642382481;6576.177977752781 07:33:01 INFO - PID 20657 | |1;ext.html;749.6102026945987;782.9725959591416;783.5690370296337;783.6630248992934;785.3599316557005;38414.61585384145;42257.78871105644;42296.365554516706;42442.787786061024;42542;39476.21047579047;39539.80230098846;39659;39668.80165599175;39681;7064.399526040293;7183.102112235971;7193.748218812342;7930.365570754355;8209.425340226157;7996.400269979746;8097;8097.838043239131;8098.109207987117;8108.067572229181;8036.678532858678;8066.274035336818;8111.675532978674;8125.715599954003;8133.146019667938;7990.880136797953;7997.920020799834;8021.919780802234;8053.154418786002;8095.433319667625;7933.761987140395;7970.123286438487;7973.08309544404;8004.319632831216;8007.559584222866;38343.2745526452;38494.42258366127;38631.80684096562;38946;38960.80519597384;3529.523514325559;3573.231755172624;3579.4093974494176;3580.874669386559;3582.677559019675;31519.21201969969;31570;31660;31694.366112677617;31697.524537131732;5164.612654050924;5210.6613070150315;5215.087359712035;5250.474952504719;5269.86825329366;187224;188161;189945;190140;190348.9999999986;41299.38050929239;41879;47644.28533571999;48414;48569.514304857206;52291;52941;53317.46682533203;53360.73319633455;53378.46621533735;15020.17389043613;15146.318415671321;15166.924165379103;15185.924070379577;15207.695846083016;12100.394980250952;12121.27272363661;12153.635390938285;12208.511659533518;12212.145149839604;14395.568132956028;14461.349239284258;14467.565973020826;14531.564053078424;14712.852871471363;5549.72251387429;5626.690532020778;5639.182318563785;5805.767769289266;5821.650700957872;999.9850002249972;1026.081656917055;1026.1790567545934;1030.3096925060227;1055.3562326980536;22686.773132268798;23057.077716891472;23106.306810795704;23267.3019809406;23489;1111.3776285280107;1115.130198445214;1120.971975700614;1131.2477202660302;1133.206755271297;12083.516659333704;12240.326782027074;12311.476147389763;12315.815262771066;12456.688582785502;228408;228439;228742;229372;230096;51741;51797.74101129545;51981;51983.22025169626;52206.47793522016;1429.9142051476945;1435.8133442652388;1454.8870114362521;1466.7873158392188;1471.6909449015614;22286.66570001419;22353.664695029263;22382.104715811187;22383.664245036663;23165.378423510192;37135;37181;37203.441948371335;37266.441003384425;37274.440883386225;186830.0658496699;187294;188284;188328;188456;33047.17382065467;35729.82135089412;35985;36022.099447514025;36247.91256262316;44672;45866.312005319276;46091.30863037124;46199.30701039554;46213.76893115513;33307.83346083254;33703.494447582816;33807.32385352328;33890.49164262587;33934.151646208054;32738;32821.507677385336;33254.33491330208;33332;33460.83269583636;37245.441318380785;37318.25363492661;37589.872303830925;37642.43536347012;37686.2462750738;32272.35455290928;32478.188045299055;33085;33246.335073297916;33307.83346083254;23119.88440057789;23761.405964851016;24200.63699044551;24433.633495497936;24464.75535244696 07:33:01 INFO - PID 20657 | |2;jquery.html;560.4059696721475;576.1731914702402;582.2052897794506;594.8988671925773;605.3764622438888;21636.89181554092;22402.215922442698;22566.77433225667;22601.773982260172;22608.095676172954;23614;24200.757992420116;24288.271351859472;24324;24435.511289774193;6570.770023049195;6777.356151165632;6781.491388145884;6781.525293229476;6782.050512928194;6262.2172228471445;6608.273089960125;6675.065490831287;6680.365365290289;6691.531592788507;6474.255460622018;6509.869802603945;6516.967415162918;6521.445677117427;6527.053577231299;6392.680365981682;6509.446697030734;6519.8044058678315;6524.086627872101;6530.2163740351225;6199;6201.658908760016;6202.534809889231;6202.782902598433;6208.441240288395;28023.85988070067;28379.722912468987;28455.857720711265;28464.573031404547;28517.714822851714;2049.7130401743766;2069.3998740365278;2069.513664288891;2071.8238949689294;2072.9481762955897;18931.905340473346;19372.612547748966;19644.410667679993;19672.901635491875;19796.208151673916;2334.498082912182;2384.1655420602824;2386.296042667417;2446.510697860417;2486.589712697403;121483;126444;128407;131238.3438082813;134903.32548337293;14705.558833234805;14758;14895.77656335156;15094.264159621784;15294.923525382303;23304.7669523306;23318;23384.298471045895;23428.531429371316;23456.882715586315;9670.129688328085;9744.174189485111;9799.265055120895;9804;9810.80378392428;8749.693760718344;8749.737507874774;8819.603117859711;8856.468611883307;8939.195472407515;8975.50634715097;9045.864312035324;9054.547272636342;9183.862242066374;9311.115444032806;2747.6290700755544;2760.7653349465522;2789.986050069737;2818.25316291183;2882.884684612634;937.5780898595659;950.135376807116;968.5738275158908;978.7699890525721;980.1129977370349;18561.5359616008;18715.625687486176;18759.624807503773;18876.433706988813;19140.8085919139;995.869687904234;1002.8044531316469;1005.2109094360892;1019.50553981319;1021.5454122915231;10318.226133040052;10542.631007914686;10582.259241853151;10631.94684026575;10653.84019239712;448704;449820;455668;459995;464332;101516.49241753743;102760.44346961561;102887;103462.48268758607;103661;1051.9263651544318;1171.0280467212365;1173.3077484284142;1174.48322737995;1174.812030075201;16450.259738311564;16563.91718041402;16714.916425417796;16983.150842458075;17004;51653;52578.73710631422;53035.73482132565;53347;55640.72179639076;64241.35758642354;64815.67592162009;64902;65011.34988650053;65801.34198657951;14042.648933776738;14169.43322267139;14270.714585708436;14299.285035747964;14410.927945360207;21529;21675.89162054243;21710.131594736664;21779.237726680123;21935.341939741196;16852.1573921301;16939.23773430174;16994.320227191267;17002.91498542549;17250.137493125545;15528.689426211638;15530.84469155294;15708.921455393107;16281.67436651284;16472.588185294982;17669.116544172997;17810.753247272565;18041.368552100612;18191.090445477937;18410.723839142156;13961.74344309017;14115.929420352833;14134.434622614981;14145.858541414866;14251.786223206453;17098.914505427394;17326.480205593853;17466.563335916195;17596.120193990504;17651 07:33:01 INFO - PID 20657 | |3;mootools.html;1320.5906169087584;1363.9113457625253;1367.3505085084587;1375.6079517337562;1381.6960268740872;14921.477748278812;15673;15706.057636541802;15711.842881571181;15715.44995925143;15376.923115384436;15420.61448463789;15485.14831684257;15494.767578486304;15509.844901551009;2593.196109206143;2746.6566679165103;2747.5329194036963;2749.5738160585042;2750.188694335166;2664.5869890167055;2692.1250593557074;2723.087765598527;2731.0987374166575;2731.1396909973396;2766.405222877081;2788.9820215621353;2796.272969028047;2796.3708165662765;2797.4125433658855;2632.1577095329503;2656.189862092061;2656.6015097735303;2666.1068542038443;2679.6784385873625;2503.849769013865;2619.2796980830235;2753.0914798116773;2755.200991712401;2756.6967633560294;15422.845771542365;15540.922295388564;15542.300596473186;15553.22233888301;15572.454964076316;8183.345332373396;8441.915580844236;8480.491170529787;8484.19400156984;8489.3208543317;5177.974110129463;5372.7313634318125;5429.83710488682;5499.642523235977;5501.4223506532035;1917.5781328107794;1936.1577713694446;1936.5933154037668;1964.0866996846391;1994.8803071815737;26131.869340653175;26467.602985955225;26552.070677526386;26597.867010665017;26687.733122668913;6874.106366172366;7028.92971070293;7046.401055910203;7062.646867656596;7199.1361036675935;17661.646767064587;17692.31922967342;17707.557311067325;17721.468355949342;17726.734098988527;7886.684532618746;8173.346132309401;8175.2233537815;8177.591120443954;8186;7313.926860731431;7336.523125996793;7498.512596681198;7503.5497870127965;7542.208068152875;5351.1973204019705;5547.164356178978;5554.1946417770005;5575.107982722745;5602.85992850182;1565.2643257668879;1565.585119943216;1570.3090640118312;1574.2050264616296;1609.1069456451548;876.237673224299;894.3381897395881;901.9052999435096;905.4431524612447;907.3240435875315;7739.61301934901;7828.217178282126;7865.724699635485;7973.0830954439825;7980.3615710743;642.8360768004222;658.154271760785;709.6664567653298;709.9219085900547;714.3285311806885;4517.661175411858;4982.576480999156;5044.192929131322;5337.893242135136;5479.616426850162;21203.787962120183;21646.458838529164;22117.447063823212;22191.334259972227;22465.213717519808;21367.35897923065;21721.565568688537;22696.43258918507;22875;22945.31164065081;10920.726981825517;11149.498272577754;11216.046636035866;11286.830697539543;11288.153388495895;8520.19058189471;8752.168543988311;8831.514266715136;8930.285577153942;8976;18363.17365718519;18930.810691892904;18992.810071899105;19192.71210931865;19257;19139;19259.90370048141;19447.902760486108;19595.118219680433;20005.299814506423;12293.815592766294;12594.87405125937;12620.495180192689;12627.431765570755;12647.367631618567;14020.719585608434;14059.437622494986;14238.786418203943;14286.142831430148;14377.496787612383;11465.484053217791;11552.94223528877;11609.709757255798;11676.94161529187;11953.462094205956;10696.572137114428;10800.945995270287;10829.620963266249;10974.286671366655;11103.72240693989;10204.846927295948;10286.639967601099;10292.763305273133;10400.219983501116;10420.68737937863;6999.545029573062;7023.648817558999;7105.644717764195;7132.500724949204;7172.533785303938;7392.55644661322;7420.777376678709;7427.628618569158;7441.255874412515;7495.887561686688 07:33:01 INFO - PID 20657 | |4;prototype.html;516.8630312967063;544.4147541393003;544.7548603128594;549.4972100528017;554.4261689151729;6386.872262554758;6430.485561155108;6445.516586256032;6452.193475815523;6474.838129046776;6155.599886007418;6200.658963756991;6233.594816336947;6261.968690156543;6270.27891792444;5192.221166824987;5196.324477817888;5221.738913054332;5235.502627250406;5235.528802407783;4912.164931961575;5220.642632915431;5230.92153617696;5279.231457461755;5299.867503312409;5021.748912554376;5039.19372900336;5041.319421878036;5058.747062646871;5106.897862042757;5034.597232221414;5068;5070.898582028376;5077.543021128097;5087.26234695967;4546.29532422475;4555.726656400627;4556.384888040106;4557.541586692259;4592.242280023792;6230.750769969196;6236.002239641635;6268.1851359323455;6277.591956522811;6279.654618995954;5708.628939118944;5798.797042103548;5840.970795145997;5842.211301474289;5857.941420585782;6435.903461448082;6512.837179070514;6538.934610653881;6542.775456344818;6577.177852768404;4893.608511319086;4936.333594964705;4938.4320803107385;4938.950610493885;4954.578860796837;6605.471562275006;6829.180498340182;6852.45180385568;6868.107146071029;6885.414739747128;5010.849674509771;5020.447750747415;5033.647644664911;5064.5441910228255;5090.974545127251;5048.72232027242;5075.619328550373;5106.259592359087;5139.229115632685;5144.768485418165;5633.943660563424;5635.492805647511;5662.348829884533;5763.596548241583;5784.971075144682;6694.230163531256;6698.63157526331;6721;6724;6744.7976560703255;1781.6436712657262;1783.839454449106;1787.6067265201634;1796.1647833757365;1802.1890149432809;1181.6573193773881;1209.673388185185;1216.5863606373875;1227.6746662134542;1251.3743128435783;5660;5677;5739.799107031317;5740.712964351766;5784.132380143013;6745.797626071226;6752.724928409815;6773.491988100912;6801.625910574966;6847.897281540781;5645.237892884408;5685.744141513559;5706.343770466367;5706.600537962386;5725.484706376446;3532.4701294805473;3549.2723991581665;3565.9108522286633;3606.8737594184076;3621.6378362163573;6569.80290591283;6572.605643661395;6576.704048317837;6592.80221593353;6613.338666133444;6538.855700252437;6848.897266541006;6953;6979.336962988508;7015.964920175366;6461.676916154173;6487.2539657939;6537.542372034007;6568.47452203813;6571.34286571339;6613.10723052401;6621.966890165519;6678.699458524476;6701.3477654677345;6797.218319893275;6603.537752357289;6623.575931174821;6627.4698024158915;6682.431993280431;6687.732490700318;6382.297947225708;6385.8722825544155;6419.679016049272;6496.415322620986;6497.8700425992165;4941.851744447672;4980.228064649985;5004.3994720633755;5041.7227052511;5060.861306206074;6563.3764792344655;6573.112629794917;6716.361945615159;6750.434834762758;6835.316468353125;6466.579672321284;6545.345465453416;6606.339366063356;6621.966890165519;6640;6537.70580323877;6551.705173267119;6600.141981542369;6615.933840661532;6618.371254730793;6417.523969486951;6451.3226111257645;6473.902891456726;6520.989246666774;6530.444912182517;6638.302978187221;6659.600423974383;6663.300353463011;6690.565113267622;6736.461083113241;6404.807855764335;6432.549721519636;6439.549231553746;6441.710123044568;6451.645159516084 07:33:01 INFO - PID 20657 | |5;yui.html;901.3690416708305;919.2875521470855;927.9628814847406;929.7257309093817;946.3612061858244;19810.30663926763;20553.794462055394;20600.69098963513;20615.690764638504;20623.17507299708;17378.913105434487;17486.125693715294;17517.299308027665;17612.471625851245;17669.7349539757;951.2247518272603;962.273483519945;964.9421034737938;966.2221911361352;966.864638950544;969.9030096990315;975.3416443900375;975.4439969217549;976.7411635916487;978.1196922769493;1003.4982508745627;1019.2457581389792;1023.3194925374617;1023.6161439460202;1039.4646756920154;1033.700226934192;1034.5603118674571;1035.5805898611075;1037.4086770540796;1038.4703801061512;754.6000619671582;757.7234309477057;760.8744557148063;760.8972788673569;761.7943155348025;20722.585548289102;20760.896195518926;21405.571888562295;21480.248191313385;21484.677729833908;21956;22007.449813754625;22308.330750077363;22412.887935560382;22513.887430562907;17284.56788580283;17301.653966920592;17429.30282788687;17507.824921750875;17516.474505764847;3809.0667786392232;3830.195658911632;3837.827297771607;3838.309104361214;3873.9418908716393;108876;136429;137415;137486;137803;17534.12329383526;17878.374256900945;17948.641027179383;17990.550236243937;17997.820021799875;31275.530867037014;32140.517892231634;32234.35531289361;32287.51568726471;32340.191495212806;8986.05646407131;9025.187733103921;9057.09429057089;9083.727488175366;9139.268858491305;4288.292431748727;4330.437043184366;4349.847755328548;4350.760708161019;4360.585744354281;5501.752421140978;5632.986062508788;5647.6893770843;5649.548036157097;5655.434456554394;1118.546988469671;1130.3669944830922;1143.9084873210122;1145.1640302579165;1149.0807354116673;691.1913061717802;694.4028135803205;710.2435905760349;715.6242972439511;725.2529894208973;10560.841587376195;10762.098869040501;11006;11163.888361116286;11236.213465057532;648.6562122075308;655.446148004935;666.5367569539221;667.1926968368329;670.9463242940553;4917.680350777188;4953.083679519301;4959.057779021974;4963.404391473046;5033.572146367526;120712.39643801725;121467.39266303788;124402.37798810948;124488;127474;105204;107383.46308268409;108964.4551777236;114280;114990;93776;93873.5306323464;94530;98638.5068074655;100250.99749002709;9520.428774273565;9574.712758617252;9639.807203855744;9717.805643887225;9822.705318840446;42802.35796463118;43797.88206955595;44432;45308.77345613383;46271.53728462672;55820.44179558315;56310;58739.4126058734;58803;59171.704141479015;16569.25438355301;16784.832151678816;16889.493315200565;16896;17056.31774728997;18375.816241837412;18757.249710011445;18777.436676899713;18784.15471303767;18894.244230231187;13698.972577056562;13776.311184440538;13933.512327068504;13970.441182352999;14178.787318190029;16314.347426103297;16591.834081659028;16770.0776457296;16925.66148677044;16929.492115236564;14664.78002829937;14875.851241487446;15039;15050.322735477148;15117.773233401727;12047.277163369876;12371.381430928597;12404.81392779091;12509.87490125087;12566.623001309976;11244.775104498029;11313.886861131283;11382.94308528452;11446.656600302003;11500.309981401142 07:33:01 INFO - PID 20657 | __end_tp_report 07:33:01 INFO - PID 20657 | __start_cc_report 07:33:01 INFO - PID 20657 | _x_x_mozilla_cycle_collect,280 07:33:01 INFO - PID 20657 | __end_cc_report 07:33:01 INFO - PID 20657 | __startTimestamp1506004381438__endTimestamp 07:33:01 INFO - PID 20657 | 07:33:01 INFO - PID 20657 | ------- Summary: start ------- 07:33:01 INFO - PID 20657 | Number of tests: 6 07:33:01 INFO - PID 20657 | 07:33:01 INFO - PID 20657 | [#0] dojo.html Cycles:165 Average:6283.60 Median:6526.87 stddev:760.99 (11.7%) stddev-sans-first:722.91 07:33:01 INFO - PID 20657 | Values: 3164.2 3181.8 3182.6 3192.6 3201.1 6288.1 6334.9 6339.0 6446.5 6507.8 6309.7 6321.3 6362.9 6399.2 6426.9 5846.3 5847.1 5859.9 5862.0 5896.2 5853.0 5872.5 5911.4 5958.4 5985.1 5888.6 5959.4 5963.9 5981.1 6009.0 5695.0 5808.1 5880.2 5924.5 5976.9 5302.5 5769.9 5779.2 5912.6 5921.1 6361.9 6401.9 6403.0 6468.4 6475.0 6648.4 6649.4 6787.6 6832.9 6932.1 6896.6 6907.8 6923.5 6924.0 6932.8 6398.8 6401.6 6425.7 6445.9 6450.7 6946.5 7033.8 7099.8 7124.6 7137.3 6620.8 6693.5 6751.9 6833.4 6834.4 6768.7 6780.8 6797.7 6828.8 6845.7 6748.2 6831.1 6873.3 6877.6 6880.3 6815.1 6825.4 6833.9 6915.9 6923.7 5257.6 5329.4 5356.4 5361.9 5424.2 4680.6 4738.9 4739.1 4743.8 4755.6 5770.7 5849.9 5855.6 5868.9 5891.4 6755.7 6832.0 6869.8 6931.1 6952.2 5638.2 5784.2 5797.8 5859.8 5860.6 5854.8 5871.9 5927.1 5934.3 5940.6 6615.4 6624.6 6707.9 6710.7 6712.7 6574.4 6809.3 6811.0 6811.8 6812.9 6511.4 6516.6 6516.8 6517.3 6558.7 6671.4 6739.9 6831.1 6831.8 6837.6 6873.8 6877.1 6963.9 6972.5 6977.1 6606.8 6611.3 6697.0 6706.8 6721.0 6486.1 6578.4 6578.5 6598.4 6702.2 6526.9 6541.6 6544.3 6548.1 6553.7 6650.8 6672.6 6751.1 6767.4 6824.9 6490.1 6494.9 6565.1 6565.3 6576.2 07:33:01 INFO - PID 20657 | 07:33:01 INFO - PID 20657 | [#1] ext.html Cycles:180 Average:37389.32 Median:19783.84 stddev:52532.27 (265.5%) stddev-sans-first:52607.59 07:33:01 INFO - PID 20657 | Values: 749.6 783.0 783.6 783.7 785.4 38414.6 42257.8 42296.4 42442.8 42542.0 39476.2 39539.8 39659.0 39668.8 39681.0 7064.4 7183.1 7193.7 7930.4 8209.4 7996.4 8097.0 8097.8 8098.1 8108.1 8036.7 8066.3 8111.7 8125.7 8133.1 7990.9 7997.9 8021.9 8053.2 8095.4 7933.8 7970.1 7973.1 8004.3 8007.6 38343.3 38494.4 38631.8 38946.0 38960.8 3529.5 3573.2 3579.4 3580.9 3582.7 31519.2 31570.0 31660.0 31694.4 31697.5 5164.6 5210.7 5215.1 5250.5 5269.9 187224.0 188161.0 189945.0 190140.0 190349.0 41299.4 41879.0 47644.3 48414.0 48569.5 52291.0 52941.0 53317.5 53360.7 53378.5 15020.2 15146.3 15166.9 15185.9 15207.7 12100.4 12121.3 12153.6 12208.5 12212.1 14395.6 14461.3 14467.6 14531.6 14712.9 5549.7 5626.7 5639.2 5805.8 5821.7 1000.0 1026.1 1026.2 1030.3 1055.4 22686.8 23057.1 23106.3 23267.3 23489.0 1111.4 1115.1 1121.0 1131.2 1133.2 12083.5 12240.3 12311.5 12315.8 12456.7 228408.0 228439.0 228742.0 229372.0 230096.0 51741.0 51797.7 51981.0 51983.2 52206.5 1429.9 1435.8 1454.9 1466.8 1471.7 22286.7 22353.7 22382.1 22383.7 23165.4 37135.0 37181.0 37203.4 37266.4 37274.4 186830.1 187294.0 188284.0 188328.0 188456.0 33047.2 35729.8 35985.0 36022.1 36247.9 44672.0 45866.3 46091.3 46199.3 46213.8 33307.8 33703.5 33807.3 33890.5 33934.2 32738.0 32821.5 33254.3 33332.0 33460.8 37245.4 37318.3 37589.9 37642.4 37686.2 32272.4 32478.2 33085.0 33246.3 33307.8 23119.9 23761.4 24200.6 24433.6 24464.8 07:33:01 INFO - PID 20657 | 07:33:01 INFO - PID 20657 | [#2] jquery.html Cycles:180 Average:32603.91 Median:12826.25 stddev:76574.86 (597.0%) stddev-sans-first:76751.88 07:33:01 INFO - PID 20657 | Values: 560.4 576.2 582.2 594.9 605.4 21636.9 22402.2 22566.8 22601.8 22608.1 23614.0 24200.8 24288.3 24324.0 24435.5 6570.8 6777.4 6781.5 6781.5 6782.1 6262.2 6608.3 6675.1 6680.4 6691.5 6474.3 6509.9 6517.0 6521.4 6527.1 6392.7 6509.4 6519.8 6524.1 6530.2 6199.0 6201.7 6202.5 6202.8 6208.4 28023.9 28379.7 28455.9 28464.6 28517.7 2049.7 2069.4 2069.5 2071.8 2072.9 18931.9 19372.6 19644.4 19672.9 19796.2 2334.5 2384.2 2386.3 2446.5 2486.6 121483.0 126444.0 128407.0 131238.3 134903.3 14705.6 14758.0 14895.8 15094.3 15294.9 23304.8 23318.0 23384.3 23428.5 23456.9 9670.1 9744.2 9799.3 9804.0 9810.8 8749.7 8749.7 8819.6 8856.5 8939.2 8975.5 9045.9 9054.5 9183.9 9311.1 2747.6 2760.8 2790.0 2818.3 2882.9 937.6 950.1 968.6 978.8 980.1 18561.5 18715.6 18759.6 18876.4 19140.8 995.9 1002.8 1005.2 1019.5 1021.5 10318.2 10542.6 10582.3 10631.9 10653.8 448704.0 449820.0 455668.0 459995.0 464332.0 101516.5 102760.4 102887.0 103462.5 103661.0 1051.9 1171.0 1173.3 1174.5 1174.8 16450.3 16563.9 16714.9 16983.2 17004.0 51653.0 52578.7 53035.7 53347.0 55640.7 64241.4 64815.7 64902.0 65011.3 65801.3 14042.6 14169.4 14270.7 14299.3 14410.9 21529.0 21675.9 21710.1 21779.2 21935.3 16852.2 16939.2 16994.3 17002.9 17250.1 15528.7 15530.8 15708.9 16281.7 16472.6 17669.1 17810.8 18041.4 18191.1 18410.7 13961.7 14115.9 14134.4 14145.9 14251.8 17098.9 17326.5 17466.6 17596.1 17651.0 07:33:01 INFO - PID 20657 | 07:33:01 INFO - PID 20657 | [#3] mootools.html Cycles:180 Average:9511.60 Median:26509.84 stddev:6812.99 (25.7%) stddev-sans-first:6804.31 07:33:01 INFO - PID 20657 | Values: 1320.6 1363.9 1367.4 1375.6 1381.7 14921.5 15673.0 15706.1 15711.8 15715.4 15376.9 15420.6 15485.1 15494.8 15509.8 2593.2 2746.7 2747.5 2749.6 2750.2 2664.6 2692.1 2723.1 2731.1 2731.1 2766.4 2789.0 2796.3 2796.4 2797.4 2632.2 2656.2 2656.6 2666.1 2679.7 2503.8 2619.3 2753.1 2755.2 2756.7 15422.8 15540.9 15542.3 15553.2 15572.5 8183.3 8441.9 8480.5 8484.2 8489.3 5178.0 5372.7 5429.8 5499.6 5501.4 1917.6 1936.2 1936.6 1964.1 1994.9 26131.9 26467.6 26552.1 26597.9 26687.7 6874.1 7028.9 7046.4 7062.6 7199.1 17661.6 17692.3 17707.6 17721.5 17726.7 7886.7 8173.3 8175.2 8177.6 8186.0 7313.9 7336.5 7498.5 7503.5 7542.2 5351.2 5547.2 5554.2 5575.1 5602.9 1565.3 1565.6 1570.3 1574.2 1609.1 876.2 894.3 901.9 905.4 907.3 7739.6 7828.2 7865.7 7973.1 7980.4 642.8 658.2 709.7 709.9 714.3 4517.7 4982.6 5044.2 5337.9 5479.6 21203.8 21646.5 22117.4 22191.3 22465.2 21367.4 21721.6 22696.4 22875.0 22945.3 10920.7 11149.5 11216.0 11286.8 11288.2 8520.2 8752.2 8831.5 8930.3 8976.0 18363.2 18930.8 18992.8 19192.7 19257.0 19139.0 19259.9 19447.9 19595.1 20005.3 12293.8 12594.9 12620.5 12627.4 12647.4 14020.7 14059.4 14238.8 14286.1 14377.5 11465.5 11552.9 11609.7 11676.9 11953.5 10696.6 10800.9 10829.6 10974.3 11103.7 10204.8 10286.6 10292.8 10400.2 10420.7 6999.5 7023.6 7105.6 7132.5 7172.5 7392.6 7420.8 7427.6 7441.3 7495.9 07:33:01 INFO - PID 20657 | 07:33:01 INFO - PID 20657 | [#4] prototype.html Cycles:180 Average:5559.71 Median:6265.08 stddev:1545.25 (24.7%) stddev-sans-first:1502.52 07:33:01 INFO - PID 20657 | Values: 516.9 544.4 544.8 549.5 554.4 6386.9 6430.5 6445.5 6452.2 6474.8 6155.6 6200.7 6233.6 6262.0 6270.3 5192.2 5196.3 5221.7 5235.5 5235.5 4912.2 5220.6 5230.9 5279.2 5299.9 5021.7 5039.2 5041.3 5058.7 5106.9 5034.6 5068.0 5070.9 5077.5 5087.3 4546.3 4555.7 4556.4 4557.5 4592.2 6230.8 6236.0 6268.2 6277.6 6279.7 5708.6 5798.8 5841.0 5842.2 5857.9 6435.9 6512.8 6538.9 6542.8 6577.2 4893.6 4936.3 4938.4 4939.0 4954.6 6605.5 6829.2 6852.5 6868.1 6885.4 5010.8 5020.4 5033.6 5064.5 5091.0 5048.7 5075.6 5106.3 5139.2 5144.8 5633.9 5635.5 5662.3 5763.6 5785.0 6694.2 6698.6 6721.0 6724.0 6744.8 1781.6 1783.8 1787.6 1796.2 1802.2 1181.7 1209.7 1216.6 1227.7 1251.4 5660.0 5677.0 5739.8 5740.7 5784.1 6745.8 6752.7 6773.5 6801.6 6847.9 5645.2 5685.7 5706.3 5706.6 5725.5 3532.5 3549.3 3565.9 3606.9 3621.6 6569.8 6572.6 6576.7 6592.8 6613.3 6538.9 6848.9 6953.0 6979.3 7016.0 6461.7 6487.3 6537.5 6568.5 6571.3 6613.1 6622.0 6678.7 6701.3 6797.2 6603.5 6623.6 6627.5 6682.4 6687.7 6382.3 6385.9 6419.7 6496.4 6497.9 4941.9 4980.2 5004.4 5041.7 5060.9 6563.4 6573.1 6716.4 6750.4 6835.3 6466.6 6545.3 6606.3 6622.0 6640.0 6537.7 6551.7 6600.1 6615.9 6618.4 6417.5 6451.3 6473.9 6521.0 6530.4 6638.3 6659.6 6663.3 6690.6 6736.5 6404.8 6432.5 6439.5 6441.7 6451.6 07:33:01 INFO - PID 20657 | 07:33:01 INFO - PID 20657 | [#5] yui.html Cycles:180 Average:24282.82 Median:20672.88 stddev:34895.20 (168.8%) stddev-sans-first:34948.92 07:33:01 INFO - PID 20657 | Values: 901.4 919.3 928.0 929.7 946.4 19810.3 20553.8 20600.7 20615.7 20623.2 17378.9 17486.1 17517.3 17612.5 17669.7 951.2 962.3 964.9 966.2 966.9 969.9 975.3 975.4 976.7 978.1 1003.5 1019.2 1023.3 1023.6 1039.5 1033.7 1034.6 1035.6 1037.4 1038.5 754.6 757.7 760.9 760.9 761.8 20722.6 20760.9 21405.6 21480.2 21484.7 21956.0 22007.4 22308.3 22412.9 22513.9 17284.6 17301.7 17429.3 17507.8 17516.5 3809.1 3830.2 3837.8 3838.3 3873.9 108876.0 136429.0 137415.0 137486.0 137803.0 17534.1 17878.4 17948.6 17990.6 17997.8 31275.5 32140.5 32234.4 32287.5 32340.2 8986.1 9025.2 9057.1 9083.7 9139.3 4288.3 4330.4 4349.8 4350.8 4360.6 5501.8 5633.0 5647.7 5649.5 5655.4 1118.5 1130.4 1143.9 1145.2 1149.1 691.2 694.4 710.2 715.6 725.3 10560.8 10762.1 11006.0 11163.9 11236.2 648.7 655.4 666.5 667.2 670.9 4917.7 4953.1 4959.1 4963.4 5033.6 120712.4 121467.4 124402.4 124488.0 127474.0 105204.0 107383.5 108964.5 114280.0 114990.0 93776.0 93873.5 94530.0 98638.5 100251.0 9520.4 9574.7 9639.8 9717.8 9822.7 42802.4 43797.9 44432.0 45308.8 46271.5 55820.4 56310.0 58739.4 58803.0 59171.7 16569.3 16784.8 16889.5 16896.0 17056.3 18375.8 18757.2 18777.4 18784.2 18894.2 13699.0 13776.3 13933.5 13970.4 14178.8 16314.3 16591.8 16770.1 16925.7 16929.5 14664.8 14875.9 15039.0 15050.3 15117.8 12047.3 12371.4 12404.8 12509.9 12566.6 11244.8 11313.9 11382.9 11446.7 11500.3 07:33:01 INFO - PID 20657 | -------- Summary: end -------- 07:33:01 INFO - PID 20657 | 07:33:02 INFO - TEST-INFO | 20657: exit 0 07:33:02 INFO - TEST-OK | dromaeo_css | took 1108833ms 07:33:02 INFO - TEST-START | kraken 07:33:02 INFO - Initialising browser for kraken test... 07:33:02 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50013/getInfo.html -profile /tmp/tmpEvMKqq/profile 07:33:02 INFO - TEST-INFO | started process 21023 (/builds/slave/test/build/application/firefox/firefox http://localhost:50013/getInfo.html) 07:33:07 INFO - TEST-INFO | 21023: exit 0 07:33:07 INFO - Browser initialized. 07:33:07 INFO - Running cycle 1/1 for kraken test... 07:33:07 INFO - Using env: {'DISPLAY': ':0', 07:33:07 INFO - 'HOME': '/home/cltbld', 07:33:07 INFO - 'JSGC_DISABLE_POISONING': '1', 07:33:07 INFO - 'LANG': 'en_US.UTF-8', 07:33:07 INFO - 'LANGUAGE': 'en_US:en', 07:33:07 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 07:33:07 INFO - 'LOGNAME': 'cltbld', 07:33:07 INFO - 'MAIL': '/var/mail/cltbld', 07:33:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:33:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:33:07 INFO - 'MOZ_CRASHREPORTER': '1', 07:33:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:07 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 07:33:07 INFO - 'MOZ_NO_REMOTE': '1', 07:33:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:33:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:33:07 INFO - 'NO_EM_RESTART': '1', 07:33:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:33:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:07 INFO - 'PWD': '/builds/slave/test', 07:33:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:33:07 INFO - 'RUST_BACKTRACE': 'full', 07:33:07 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:33:07 INFO - 'SHELL': '/bin/bash', 07:33:07 INFO - 'SHLVL': '1', 07:33:07 INFO - 'STYLO_FORCE_DISABLED': '1', 07:33:07 INFO - 'TERM': 'linux', 07:33:07 INFO - 'TMOUT': '86400', 07:33:07 INFO - 'USER': 'cltbld', 07:33:07 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1506003178.747299-300798062', 07:33:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:07 INFO - '_': '/tools/buildbot/bin/python'} 07:33:07 INFO - TEST-INFO | started process 21254 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEvMKqq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:33:08 INFO - PID 21254 | 07:33:08 INFO - PID 21254 | (/builds/slave/test/build/application/firefox/firefox:21303): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:33:08 INFO - PID 21254 | 07:33:18 INFO - PID 21254 | RSS: Main: 156008448 07:33:18 INFO - PID 21254 | 07:33:21 INFO - PID 21254 | Cycle 1(1): loaded http://localhost:50013/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50013/tests/kraken/driver.html?testName=audio-beat-detection) 07:33:22 INFO - PID 21254 | RSS: Main: 162574336 07:33:22 INFO - PID 21254 | 07:33:24 INFO - PID 21254 | Cycle 1(1): loaded http://localhost:50013/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50013/tests/kraken/driver.html?testName=audio-dft) 07:33:25 INFO - PID 21254 | RSS: Main: 163209216 07:33:25 INFO - PID 21254 | 07:33:28 INFO - PID 21254 | Cycle 1(1): loaded http://localhost:50013/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50013/tests/kraken/driver.html?testName=audio-fft) 07:33:28 INFO - PID 21254 | RSS: Main: 158543872 07:33:28 INFO - PID 21254 | 07:33:31 INFO - PID 21254 | Cycle 1(1): loaded http://localhost:50013/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50013/tests/kraken/driver.html?testName=audio-oscillator) 07:33:31 INFO - PID 21254 | RSS: Main: 158982144 07:33:31 INFO - PID 21254 | 07:33:33 INFO - PID 21254 | Cycle 1(1): loaded http://localhost:50013/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50013/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:33:34 INFO - PID 21254 | RSS: Main: 159219712 07:33:34 INFO - PID 21254 | 07:33:37 INFO - PID 21254 | Cycle 1(1): loaded http://localhost:50013/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50013/tests/kraken/driver.html?testName=imaging-darkroom) 07:33:38 INFO - PID 21254 | RSS: Main: 161857536 07:33:38 INFO - PID 21254 | 07:33:41 INFO - PID 21254 | Cycle 1(1): loaded http://localhost:50013/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50013/tests/kraken/driver.html?testName=imaging-desaturate) 07:33:42 INFO - PID 21254 | RSS: Main: 161828864 07:33:42 INFO - PID 21254 | 07:33:45 INFO - PID 21254 | Cycle 1(1): loaded http://localhost:50013/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50013/tests/kraken/driver.html?testName=json-parse-financial) 07:33:46 INFO - PID 21254 | RSS: Main: 161947648 07:33:46 INFO - PID 21254 | 07:33:47 INFO - PID 21254 | Cycle 1(1): loaded http://localhost:50013/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50013/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:33:48 INFO - PID 21254 | RSS: Main: 161935360 07:33:48 INFO - PID 21254 | 07:33:49 INFO - PID 21254 | Cycle 1(1): loaded http://localhost:50013/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50013/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:33:50 INFO - PID 21254 | RSS: Main: 162066432 07:33:50 INFO - PID 21254 | 07:33:52 INFO - PID 21254 | Cycle 1(1): loaded http://localhost:50013/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50013/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:33:53 INFO - PID 21254 | RSS: Main: 158646272 07:33:53 INFO - PID 21254 | 07:33:55 INFO - PID 21254 | Cycle 1(1): loaded http://localhost:50013/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50013/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:33:56 INFO - PID 21254 | RSS: Main: 159272960 07:33:56 INFO - PID 21254 | 07:33:59 INFO - PID 21254 | Cycle 1(1): loaded http://localhost:50013/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50013/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:33:59 INFO - PID 21254 | RSS: Main: 159191040 07:33:59 INFO - PID 21254 | 07:34:01 INFO - PID 21254 | Cycle 1(1): loaded http://localhost:50013/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50013/tests/kraken/driver.html?testName=ai-astar) 07:34:01 INFO - PID 21254 | RSS: Main: 160825344 07:34:01 INFO - PID 21254 | 07:34:01 INFO - PID 21254 | __start_tp_report 07:34:01 INFO - PID 21254 | _x_x_mozilla_page_load 07:34:01 INFO - PID 21254 | _x_x_mozilla_page_load_details 07:34:01 INFO - PID 21254 | |i|pagename|runs| 07:34:01 INFO - PID 21254 | |0;ai-astar;105;107;107;108;106;109;108;108;108;108 07:34:01 INFO - PID 21254 | |1;audio-beat-detection;117;119;116;116;117;115;119;144;115;120 07:34:01 INFO - PID 21254 | |2;audio-dft;163;161;162;162;161;162;162;174;172;168 07:34:01 INFO - PID 21254 | |3;audio-fft;73;74;75;74;86;74;75;73;74;78 07:34:01 INFO - PID 21254 | |4;audio-oscillator;80;81;80;82;79;79;80;78;80;80 07:34:01 INFO - PID 21254 | |5;imaging-gaussian-blur;113;114;115;125;114;113;114;114;113;113 07:34:01 INFO - PID 21254 | |6;imaging-darkroom;153;148;147;146;148;147;148;149;149;150 07:34:01 INFO - PID 21254 | |7;imaging-desaturate;93;93;94;94;94;94;94;94;96;94 07:34:01 INFO - PID 21254 | |8;json-parse-financial;54;52;52;52;54;55;50;50;52;51 07:34:01 INFO - PID 21254 | |9;json-stringify-tinderbox;38;39;39;39;38;38;38;39;37;38 07:34:01 INFO - PID 21254 | |10;stanford-crypto-aes;74;74;78;73;77;71;76;72;73;74 07:34:01 INFO - PID 21254 | |11;stanford-crypto-ccm;114;117;121;115;111;111;113;113;110;117 07:34:01 INFO - PID 21254 | |12;stanford-crypto-pbkdf2;170;169;168;168;170;175;166;172;168;164 07:34:01 INFO - PID 21254 | |13;stanford-crypto-sha256-iterative;68;65;84;65;65;70;65;64;70;65 07:34:01 INFO - PID 21254 | __end_tp_report 07:34:01 INFO - PID 21254 | __start_cc_report 07:34:01 INFO - PID 21254 | _x_x_mozilla_cycle_collect,736 07:34:01 INFO - PID 21254 | __end_cc_report 07:34:01 INFO - PID 21254 | __startTimestamp1506004441919__endTimestamp 07:34:01 INFO - PID 21254 | 07:34:01 INFO - PID 21254 | ------- Summary: start ------- 07:34:01 INFO - PID 21254 | Number of tests: 14 07:34:01 INFO - PID 21254 | 07:34:01 INFO - PID 21254 | [#0] ai-astar Cycles:10 Average:107.40 Median:108.00 stddev:1.17 (1.1%) stddev-sans-first:0.87 07:34:01 INFO - PID 21254 | Values: 105.0 107.0 107.0 108.0 106.0 109.0 108.0 108.0 108.0 108.0 07:34:01 INFO - PID 21254 | 07:34:01 INFO - PID 21254 | [#1] audio-beat-detection Cycles:10 Average:119.80 Median:118.00 stddev:8.68 (7.4%) stddev-sans-first:9.14 07:34:01 INFO - PID 21254 | Values: 117.0 119.0 116.0 116.0 117.0 115.0 119.0 144.0 115.0 120.0 07:34:01 INFO - PID 21254 | 07:34:01 INFO - PID 21254 | [#2] audio-dft Cycles:10 Average:164.70 Median:162.50 stddev:4.83 (3.0%) stddev-sans-first:5.09 07:34:01 INFO - PID 21254 | Values: 163.0 161.0 162.0 162.0 161.0 162.0 162.0 174.0 172.0 168.0 07:34:01 INFO - PID 21254 | 07:34:01 INFO - PID 21254 | [#3] audio-fft Cycles:10 Average:75.60 Median:74.50 stddev:3.92 (5.3%) stddev-sans-first:4.04 07:34:01 INFO - PID 21254 | Values: 73.0 74.0 75.0 74.0 86.0 74.0 75.0 73.0 74.0 78.0 07:34:01 INFO - PID 21254 | 07:34:01 INFO - PID 21254 | [#4] audio-oscillator Cycles:10 Average:79.90 Median:80.00 stddev:1.10 (1.4%) stddev-sans-first:1.17 07:34:01 INFO - PID 21254 | Values: 80.0 81.0 80.0 82.0 79.0 79.0 80.0 78.0 80.0 80.0 07:34:01 INFO - PID 21254 | 07:34:01 INFO - PID 21254 | [#5] imaging-gaussian-blur Cycles:10 Average:114.80 Median:114.00 stddev:3.65 (3.2%) stddev-sans-first:3.81 07:34:01 INFO - PID 21254 | Values: 113.0 114.0 115.0 125.0 114.0 113.0 114.0 114.0 113.0 113.0 07:34:01 INFO - PID 21254 | 07:34:01 INFO - PID 21254 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:148.50 stddev:1.96 (1.3%) stddev-sans-first:1.22 07:34:01 INFO - PID 21254 | Values: 153.0 148.0 147.0 146.0 148.0 147.0 148.0 149.0 149.0 150.0 07:34:01 INFO - PID 21254 | 07:34:01 INFO - PID 21254 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.82 (0.9%) stddev-sans-first:0.78 07:34:01 INFO - PID 21254 | Values: 93.0 93.0 94.0 94.0 94.0 94.0 94.0 94.0 96.0 94.0 07:34:01 INFO - PID 21254 | 07:34:01 INFO - PID 21254 | [#8] json-parse-financial Cycles:10 Average:52.20 Median:52.00 stddev:1.69 (3.2%) stddev-sans-first:1.66 07:34:01 INFO - PID 21254 | Values: 54.0 52.0 52.0 52.0 54.0 55.0 50.0 50.0 52.0 51.0 07:34:01 INFO - PID 21254 | 07:34:01 INFO - PID 21254 | [#9] json-stringify-tinderbox Cycles:10 Average:38.30 Median:38.50 stddev:0.67 (1.8%) stddev-sans-first:0.71 07:34:01 INFO - PID 21254 | Values: 38.0 39.0 39.0 39.0 38.0 38.0 38.0 39.0 37.0 38.0 07:34:01 INFO - PID 21254 | 07:34:01 INFO - PID 21254 | [#10] stanford-crypto-aes Cycles:10 Average:74.20 Median:74.00 stddev:2.20 (3.0%) stddev-sans-first:2.33 07:34:01 INFO - PID 21254 | Values: 74.0 74.0 78.0 73.0 77.0 71.0 76.0 72.0 73.0 74.0 07:34:01 INFO - PID 21254 | 07:34:01 INFO - PID 21254 | [#11] stanford-crypto-ccm Cycles:10 Average:114.20 Median:114.50 stddev:3.39 (3.0%) stddev-sans-first:3.60 07:34:01 INFO - PID 21254 | Values: 114.0 117.0 121.0 115.0 111.0 111.0 113.0 113.0 110.0 117.0 07:34:01 INFO - PID 21254 | 07:34:01 INFO - PID 21254 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.00 Median:169.50 stddev:3.06 (1.8%) stddev-sans-first:3.22 07:34:01 INFO - PID 21254 | Values: 170.0 169.0 168.0 168.0 170.0 175.0 166.0 172.0 168.0 164.0 07:34:01 INFO - PID 21254 | 07:34:01 INFO - PID 21254 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:66.50 stddev:6.01 (9.0%) stddev-sans-first:6.37 07:34:01 INFO - PID 21254 | Values: 68.0 65.0 84.0 65.0 65.0 70.0 65.0 64.0 70.0 65.0 07:34:01 INFO - PID 21254 | -------- Summary: end -------- 07:34:01 INFO - PID 21254 | 07:34:02 INFO - PID 21254 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 07:34:02 INFO - TEST-INFO | 21254: exit 0 07:34:02 INFO - TEST-OK | kraken | took 60467ms 07:34:02 INFO - SUITE-END | took 1169s 07:34:03 INFO - Completed test suite (00:19:29) 07:34:03 INFO - javascript benchmark 07:34:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8522.093712726459, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3164.1614972032407, 3181.7613678974067, 3182.6499085100622, 3192.6328472225687, 3201.071689210129, 6288.088227207052, 6334.8733025339525, 6338.968305158479, 6446.5165112616505, 6507.772227972016, 6309.684515774205, 6321.336259692735, 6362.904556431646, 6399.1681081459465, 6426.935730642692, 5846.298444186693, 5847.122931560279, 5859.853503662422, 5862.0, 5896.204012458306, 5852.9707351463185, 5872.500837428824, 5911.438413350725, 5958.433948774881, 5985.1022346647915, 5888.617239879415, 5959.404059594028, 5963.9403605964035, 5981.1028345748055, 6009.0, 5694.9715251423895, 5808.099744539603, 5880.206172166767, 5924.466797988159, 5976.940230597682, 5302.549283310923, 5769.88460230793, 5779.248697669318, 5912.556558258105, 5921.111833225051, 6361.872762544724, 6401.871962560723, 6403.0, 6468.417842394207, 6474.967625161891, 6648.368405001517, 6649.401553860127, 6787.626680532569, 6832.863342733167, 6932.133483314586, 6896.586204827727, 6907.758228461979, 6923.5499692520325, 6923.965380173117, 6932.757353492654, 6398.808035758934, 6401.647909364983, 6425.710843012076, 6445.93554064458, 6450.709718062699, 6946.479014073965, 7033.788986330418, 7099.787006389816, 7124.643767811589, 7137.321954414322, 6620.801375958729, 6693.464522838161, 6751.91969284912, 6833.4191593715095, 6834.350736680008, 6768.69540870662, 6780.762673306509, 6797.694103765342, 6828.760993365208, 6845.691943862538, 6748.19021717397, 6831.146106736658, 6873.2783057778215, 6877.58734475933, 6880.346367095118, 6815.148106486689, 6825.419839313615, 6833.93166068333, 6915.930840691629, 6923.6884340204815, 5257.579393648499, 5329.413764485904, 5356.400973351522, 5361.865953351119, 5424.240606315119, 4680.625549955996, 4738.857834264978, 4739.052189562101, 4743.762811859462, 4755.643326750507, 5770.682612456271, 5849.912251316234, 5855.590108692436, 5868.882622347529, 5891.440313170242, 6755.729770809211, 6832.0, 6869.793906182823, 6931.098957135641, 6952.200496942815, 5638.182463542763, 5784.161296611967, 5797.797077102281, 5859.794907178229, 5860.619059761102, 5854.795082172103, 5871.911921321183, 5927.051671732502, 5934.347221805598, 5940.61386009908, 6615.404613584704, 6624.56940298879, 6707.899381509281, 6710.698018589078, 6712.664366781739, 6574.408303252731, 6809.319068093151, 6811.012403201409, 6811.795646130624, 6812.93187068123, 6511.413972742476, 6516.609003459807, 6516.837079072871, 6517.315681853337, 6558.704858281293, 6671.39957403836, 6739.898901516579, 6831.11195544576, 6831.795046148623, 6837.62393068386, 6873.793786186422, 6877.071595334566, 6963.8607227854145, 6972.51192416526, 6977.058097156819, 6606.768763093461, 6611.338866113542, 6697.0, 6706.765263215764, 6720.966395167993, 6486.091947127312, 6578.440832529289, 6578.506612004215, 6598.439132673777, 6702.229243637044, 6526.869462610816, 6541.6402097885075, 6544.312847150981, 6548.116004339353, 6553.705083271169, 6650.800475985729, 6672.633005184762, 6751.088603038527, 6767.424768894502, 6824.863502730017, 6490.123833282447, 6494.935050649433, 6565.146530950946, 6565.310642382481, 6576.177977752781], "value": 6225.111217824749, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [749.6102026945987, 782.9725959591416, 783.5690370296337, 783.6630248992934, 785.3599316557005, 38414.61585384145, 42257.78871105644, 42296.365554516706, 42442.787786061024, 42542.0, 39476.21047579047, 39539.80230098846, 39659.0, 39668.80165599175, 39681.0, 7064.399526040293, 7183.102112235971, 7193.748218812342, 7930.365570754355, 8209.425340226157, 7996.400269979746, 8097.0, 8097.838043239131, 8098.109207987117, 8108.067572229181, 8036.678532858678, 8066.274035336818, 8111.675532978674, 8125.715599954003, 8133.146019667938, 7990.880136797953, 7997.920020799834, 8021.919780802234, 8053.154418786002, 8095.433319667625, 7933.761987140395, 7970.123286438487, 7973.08309544404, 8004.319632831216, 8007.559584222866, 38343.2745526452, 38494.42258366127, 38631.80684096562, 38946.0, 38960.80519597384, 3529.523514325559, 3573.231755172624, 3579.4093974494176, 3580.874669386559, 3582.677559019675, 31519.21201969969, 31570.0, 31660.0, 31694.366112677617, 31697.524537131732, 5164.612654050924, 5210.6613070150315, 5215.087359712035, 5250.474952504719, 5269.86825329366, 187224.0, 188161.0, 189945.0, 190140.0, 190348.9999999986, 41299.38050929239, 41879.0, 47644.28533571999, 48414.0, 48569.514304857206, 52291.0, 52941.0, 53317.46682533203, 53360.73319633455, 53378.46621533735, 15020.17389043613, 15146.318415671321, 15166.924165379103, 15185.924070379577, 15207.695846083016, 12100.394980250952, 12121.27272363661, 12153.635390938285, 12208.511659533518, 12212.145149839604, 14395.568132956028, 14461.349239284258, 14467.565973020826, 14531.564053078424, 14712.852871471363, 5549.72251387429, 5626.690532020778, 5639.182318563785, 5805.767769289266, 5821.650700957872, 999.9850002249972, 1026.081656917055, 1026.1790567545934, 1030.3096925060227, 1055.3562326980536, 22686.773132268798, 23057.077716891472, 23106.306810795704, 23267.3019809406, 23489.0, 1111.3776285280107, 1115.130198445214, 1120.971975700614, 1131.2477202660302, 1133.206755271297, 12083.516659333704, 12240.326782027074, 12311.476147389763, 12315.815262771066, 12456.688582785502, 228408.0, 228439.0, 228742.0, 229372.0, 230096.0, 51741.0, 51797.74101129545, 51981.0, 51983.22025169626, 52206.47793522016, 1429.9142051476945, 1435.8133442652388, 1454.8870114362521, 1466.7873158392188, 1471.6909449015614, 22286.66570001419, 22353.664695029263, 22382.104715811187, 22383.664245036663, 23165.378423510192, 37135.0, 37181.0, 37203.441948371335, 37266.441003384425, 37274.440883386225, 186830.0658496699, 187294.0, 188284.0, 188328.0, 188456.0, 33047.17382065467, 35729.82135089412, 35985.0, 36022.099447514025, 36247.91256262316, 44672.0, 45866.312005319276, 46091.30863037124, 46199.30701039554, 46213.76893115513, 33307.83346083254, 33703.494447582816, 33807.32385352328, 33890.49164262587, 33934.151646208054, 32738.0, 32821.507677385336, 33254.33491330208, 33332.0, 33460.83269583636, 37245.441318380785, 37318.25363492661, 37589.872303830925, 37642.43536347012, 37686.2462750738, 32272.35455290928, 32478.188045299055, 33085.0, 33246.335073297916, 33307.83346083254, 23119.88440057789, 23761.405964851016, 24200.63699044551, 24433.633495497936, 24464.75535244696], "value": 17207.46977039738, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.4059696721475, 576.1731914702402, 582.2052897794506, 594.8988671925773, 605.3764622438888, 21636.89181554092, 22402.215922442698, 22566.77433225667, 22601.773982260172, 22608.095676172954, 23614.0, 24200.757992420116, 24288.271351859472, 24324.0, 24435.511289774193, 6570.770023049195, 6777.356151165632, 6781.491388145884, 6781.525293229476, 6782.050512928194, 6262.2172228471445, 6608.273089960125, 6675.065490831287, 6680.365365290289, 6691.531592788507, 6474.255460622018, 6509.869802603945, 6516.967415162918, 6521.445677117427, 6527.053577231299, 6392.680365981682, 6509.446697030734, 6519.8044058678315, 6524.086627872101, 6530.2163740351225, 6199.0, 6201.658908760016, 6202.534809889231, 6202.782902598433, 6208.441240288395, 28023.85988070067, 28379.722912468987, 28455.857720711265, 28464.573031404547, 28517.714822851714, 2049.7130401743766, 2069.3998740365278, 2069.513664288891, 2071.8238949689294, 2072.9481762955897, 18931.905340473346, 19372.612547748966, 19644.410667679993, 19672.901635491875, 19796.208151673916, 2334.498082912182, 2384.1655420602824, 2386.296042667417, 2446.510697860417, 2486.589712697403, 121483.0, 126444.0, 128407.0, 131238.3438082813, 134903.32548337293, 14705.558833234805, 14758.0, 14895.77656335156, 15094.264159621784, 15294.923525382303, 23304.7669523306, 23318.0, 23384.298471045895, 23428.531429371316, 23456.882715586315, 9670.129688328085, 9744.174189485111, 9799.265055120895, 9804.0, 9810.80378392428, 8749.693760718344, 8749.737507874774, 8819.603117859711, 8856.468611883307, 8939.195472407515, 8975.50634715097, 9045.864312035324, 9054.547272636342, 9183.862242066374, 9311.115444032806, 2747.6290700755544, 2760.7653349465522, 2789.986050069737, 2818.25316291183, 2882.884684612634, 937.5780898595659, 950.135376807116, 968.5738275158908, 978.7699890525721, 980.1129977370349, 18561.5359616008, 18715.625687486176, 18759.624807503773, 18876.433706988813, 19140.8085919139, 995.869687904234, 1002.8044531316469, 1005.2109094360892, 1019.50553981319, 1021.5454122915231, 10318.226133040052, 10542.631007914686, 10582.259241853151, 10631.94684026575, 10653.84019239712, 448704.0, 449820.0, 455668.0, 459995.0, 464332.0, 101516.49241753743, 102760.44346961561, 102887.0, 103462.48268758607, 103661.0, 1051.9263651544318, 1171.0280467212365, 1173.3077484284142, 1174.48322737995, 1174.812030075201, 16450.259738311564, 16563.91718041402, 16714.916425417796, 16983.150842458075, 17004.0, 51653.0, 52578.73710631422, 53035.73482132565, 53347.0, 55640.72179639076, 64241.35758642354, 64815.67592162009, 64902.0, 65011.34988650053, 65801.34198657951, 14042.648933776738, 14169.43322267139, 14270.714585708436, 14299.285035747964, 14410.927945360207, 21529.0, 21675.89162054243, 21710.131594736664, 21779.237726680123, 21935.341939741196, 16852.1573921301, 16939.23773430174, 16994.320227191267, 17002.91498542549, 17250.137493125545, 15528.689426211638, 15530.84469155294, 15708.921455393107, 16281.67436651284, 16472.588185294982, 17669.116544172997, 17810.753247272565, 18041.368552100612, 18191.090445477937, 18410.723839142156, 13961.74344309017, 14115.929420352833, 14134.434622614981, 14145.858541414866, 14251.786223206453, 17098.914505427394, 17326.480205593853, 17466.563335916195, 17596.120193990504, 17651.0], "value": 11621.605255832515, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1320.5906169087584, 1363.9113457625253, 1367.3505085084587, 1375.6079517337562, 1381.6960268740872, 14921.477748278812, 15673.0, 15706.057636541802, 15711.842881571181, 15715.44995925143, 15376.923115384436, 15420.61448463789, 15485.14831684257, 15494.767578486304, 15509.844901551009, 2593.196109206143, 2746.6566679165103, 2747.5329194036963, 2749.5738160585042, 2750.188694335166, 2664.5869890167055, 2692.1250593557074, 2723.087765598527, 2731.0987374166575, 2731.1396909973396, 2766.405222877081, 2788.9820215621353, 2796.272969028047, 2796.3708165662765, 2797.4125433658855, 2632.1577095329503, 2656.189862092061, 2656.6015097735303, 2666.1068542038443, 2679.6784385873625, 2503.849769013865, 2619.2796980830235, 2753.0914798116773, 2755.200991712401, 2756.6967633560294, 15422.845771542365, 15540.922295388564, 15542.300596473186, 15553.22233888301, 15572.454964076316, 8183.345332373396, 8441.915580844236, 8480.491170529787, 8484.19400156984, 8489.3208543317, 5177.974110129463, 5372.7313634318125, 5429.83710488682, 5499.642523235977, 5501.4223506532035, 1917.5781328107794, 1936.1577713694446, 1936.5933154037668, 1964.0866996846391, 1994.8803071815737, 26131.869340653175, 26467.602985955225, 26552.070677526386, 26597.867010665017, 26687.733122668913, 6874.106366172366, 7028.92971070293, 7046.401055910203, 7062.646867656596, 7199.1361036675935, 17661.646767064587, 17692.31922967342, 17707.557311067325, 17721.468355949342, 17726.734098988527, 7886.684532618746, 8173.346132309401, 8175.2233537815, 8177.591120443954, 8186.0, 7313.926860731431, 7336.523125996793, 7498.512596681198, 7503.5497870127965, 7542.208068152875, 5351.1973204019705, 5547.164356178978, 5554.1946417770005, 5575.107982722745, 5602.85992850182, 1565.2643257668879, 1565.585119943216, 1570.3090640118312, 1574.2050264616296, 1609.1069456451548, 876.237673224299, 894.3381897395881, 901.9052999435096, 905.4431524612447, 907.3240435875315, 7739.61301934901, 7828.217178282126, 7865.724699635485, 7973.0830954439825, 7980.3615710743, 642.8360768004222, 658.154271760785, 709.6664567653298, 709.9219085900547, 714.3285311806885, 4517.661175411858, 4982.576480999156, 5044.192929131322, 5337.893242135136, 5479.616426850162, 21203.787962120183, 21646.458838529164, 22117.447063823212, 22191.334259972227, 22465.213717519808, 21367.35897923065, 21721.565568688537, 22696.43258918507, 22875.0, 22945.31164065081, 10920.726981825517, 11149.498272577754, 11216.046636035866, 11286.830697539543, 11288.153388495895, 8520.19058189471, 8752.168543988311, 8831.514266715136, 8930.285577153942, 8976.0, 18363.17365718519, 18930.810691892904, 18992.810071899105, 19192.71210931865, 19257.0, 19139.0, 19259.90370048141, 19447.902760486108, 19595.118219680433, 20005.299814506423, 12293.815592766294, 12594.87405125937, 12620.495180192689, 12627.431765570755, 12647.367631618567, 14020.719585608434, 14059.437622494986, 14238.786418203943, 14286.142831430148, 14377.496787612383, 11465.484053217791, 11552.94223528877, 11609.709757255798, 11676.94161529187, 11953.462094205956, 10696.572137114428, 10800.945995270287, 10829.620963266249, 10974.286671366655, 11103.72240693989, 10204.846927295948, 10286.639967601099, 10292.763305273133, 10400.219983501116, 10420.68737937863, 6999.545029573062, 7023.648817558999, 7105.644717764195, 7132.500724949204, 7172.533785303938, 7392.55644661322, 7420.777376678709, 7427.628618569158, 7441.255874412515, 7495.887561686688], "value": 6722.054152964013, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [516.8630312967063, 544.4147541393003, 544.7548603128594, 549.4972100528017, 554.4261689151729, 6386.872262554758, 6430.485561155108, 6445.516586256032, 6452.193475815523, 6474.838129046776, 6155.599886007418, 6200.658963756991, 6233.594816336947, 6261.968690156543, 6270.27891792444, 5192.221166824987, 5196.324477817888, 5221.738913054332, 5235.502627250406, 5235.528802407783, 4912.164931961575, 5220.642632915431, 5230.92153617696, 5279.231457461755, 5299.867503312409, 5021.748912554376, 5039.19372900336, 5041.319421878036, 5058.747062646871, 5106.897862042757, 5034.597232221414, 5068.0, 5070.898582028376, 5077.543021128097, 5087.26234695967, 4546.29532422475, 4555.726656400627, 4556.384888040106, 4557.541586692259, 4592.242280023792, 6230.750769969196, 6236.002239641635, 6268.1851359323455, 6277.591956522811, 6279.654618995954, 5708.628939118944, 5798.797042103548, 5840.970795145997, 5842.211301474289, 5857.941420585782, 6435.903461448082, 6512.837179070514, 6538.934610653881, 6542.775456344818, 6577.177852768404, 4893.608511319086, 4936.333594964705, 4938.4320803107385, 4938.950610493885, 4954.578860796837, 6605.471562275006, 6829.180498340182, 6852.45180385568, 6868.107146071029, 6885.414739747128, 5010.849674509771, 5020.447750747415, 5033.647644664911, 5064.5441910228255, 5090.974545127251, 5048.72232027242, 5075.619328550373, 5106.259592359087, 5139.229115632685, 5144.768485418165, 5633.943660563424, 5635.492805647511, 5662.348829884533, 5763.596548241583, 5784.971075144682, 6694.230163531256, 6698.63157526331, 6721.0, 6724.0, 6744.7976560703255, 1781.6436712657262, 1783.839454449106, 1787.6067265201634, 1796.1647833757365, 1802.1890149432809, 1181.6573193773881, 1209.673388185185, 1216.5863606373875, 1227.6746662134542, 1251.3743128435783, 5660.0, 5677.0, 5739.799107031317, 5740.712964351766, 5784.132380143013, 6745.797626071226, 6752.724928409815, 6773.491988100912, 6801.625910574966, 6847.897281540781, 5645.237892884408, 5685.744141513559, 5706.343770466367, 5706.600537962386, 5725.484706376446, 3532.4701294805473, 3549.2723991581665, 3565.9108522286633, 3606.8737594184076, 3621.6378362163573, 6569.80290591283, 6572.605643661395, 6576.704048317837, 6592.80221593353, 6613.338666133444, 6538.855700252437, 6848.897266541006, 6953.0, 6979.336962988508, 7015.964920175366, 6461.676916154173, 6487.2539657939, 6537.542372034007, 6568.47452203813, 6571.34286571339, 6613.10723052401, 6621.966890165519, 6678.699458524476, 6701.3477654677345, 6797.218319893275, 6603.537752357289, 6623.575931174821, 6627.4698024158915, 6682.431993280431, 6687.732490700318, 6382.297947225708, 6385.8722825544155, 6419.679016049272, 6496.415322620986, 6497.8700425992165, 4941.851744447672, 4980.228064649985, 5004.3994720633755, 5041.7227052511, 5060.861306206074, 6563.3764792344655, 6573.112629794917, 6716.361945615159, 6750.434834762758, 6835.316468353125, 6466.579672321284, 6545.345465453416, 6606.339366063356, 6621.966890165519, 6640.0, 6537.70580323877, 6551.705173267119, 6600.141981542369, 6615.933840661532, 6618.371254730793, 6417.523969486951, 6451.3226111257645, 6473.902891456726, 6520.989246666774, 6530.444912182517, 6638.302978187221, 6659.600423974383, 6663.300353463011, 6690.565113267622, 6736.461083113241, 6404.807855764335, 6432.549721519636, 6439.549231553746, 6441.710123044568, 6451.645159516084], "value": 5108.910342626626, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [901.3690416708305, 919.2875521470855, 927.9628814847406, 929.7257309093817, 946.3612061858244, 19810.30663926763, 20553.794462055394, 20600.69098963513, 20615.690764638504, 20623.17507299708, 17378.913105434487, 17486.125693715294, 17517.299308027665, 17612.471625851245, 17669.7349539757, 951.2247518272603, 962.273483519945, 964.9421034737938, 966.2221911361352, 966.864638950544, 969.9030096990315, 975.3416443900375, 975.4439969217549, 976.7411635916487, 978.1196922769493, 1003.4982508745627, 1019.2457581389792, 1023.3194925374617, 1023.6161439460202, 1039.4646756920154, 1033.700226934192, 1034.5603118674571, 1035.5805898611075, 1037.4086770540796, 1038.4703801061512, 754.6000619671582, 757.7234309477057, 760.8744557148063, 760.8972788673569, 761.7943155348025, 20722.585548289102, 20760.896195518926, 21405.571888562295, 21480.248191313385, 21484.677729833908, 21956.0, 22007.449813754625, 22308.330750077363, 22412.887935560382, 22513.887430562907, 17284.56788580283, 17301.653966920592, 17429.30282788687, 17507.824921750875, 17516.474505764847, 3809.0667786392232, 3830.195658911632, 3837.827297771607, 3838.309104361214, 3873.9418908716393, 108876.0, 136429.0, 137415.0, 137486.0, 137803.0, 17534.12329383526, 17878.374256900945, 17948.641027179383, 17990.550236243937, 17997.820021799875, 31275.530867037014, 32140.517892231634, 32234.35531289361, 32287.51568726471, 32340.191495212806, 8986.05646407131, 9025.187733103921, 9057.09429057089, 9083.727488175366, 9139.268858491305, 4288.292431748727, 4330.437043184366, 4349.847755328548, 4350.760708161019, 4360.585744354281, 5501.752421140978, 5632.986062508788, 5647.6893770843, 5649.548036157097, 5655.434456554394, 1118.546988469671, 1130.3669944830922, 1143.9084873210122, 1145.1640302579165, 1149.0807354116673, 691.1913061717802, 694.4028135803205, 710.2435905760349, 715.6242972439511, 725.2529894208973, 10560.841587376195, 10762.098869040501, 11006.0, 11163.888361116286, 11236.213465057532, 648.6562122075308, 655.446148004935, 666.5367569539221, 667.1926968368329, 670.9463242940553, 4917.680350777188, 4953.083679519301, 4959.057779021974, 4963.404391473046, 5033.572146367526, 120712.39643801725, 121467.39266303788, 124402.37798810948, 124488.0, 127474.0, 105204.0, 107383.46308268409, 108964.4551777236, 114280.0, 114990.0, 93776.0, 93873.5306323464, 94530.0, 98638.5068074655, 100250.99749002709, 9520.428774273565, 9574.712758617252, 9639.807203855744, 9717.805643887225, 9822.705318840446, 42802.35796463118, 43797.88206955595, 44432.0, 45308.77345613383, 46271.53728462672, 55820.44179558315, 56310.0, 58739.4126058734, 58803.0, 59171.704141479015, 16569.25438355301, 16784.832151678816, 16889.493315200565, 16896.0, 17056.31774728997, 18375.816241837412, 18757.249710011445, 18777.436676899713, 18784.15471303767, 18894.244230231187, 13698.972577056562, 13776.311184440538, 13933.512327068504, 13970.441182352999, 14178.787318190029, 16314.347426103297, 16591.834081659028, 16770.0776457296, 16925.66148677044, 16929.492115236564, 14664.78002829937, 14875.851241487446, 15039.0, 15050.322735477148, 15117.773233401727, 12047.277163369876, 12371.381430928597, 12404.81392779091, 12509.87490125087, 12566.623001309976, 11244.775104498029, 11313.886861131283, 11382.94308528452, 11446.656600302003, 11500.309981401142], "value": 8959.682235242228, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1420.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 107.0, 107.0, 108.0, 106.0, 109.0, 108.0, 108.0, 108.0, 108.0], "value": 107.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 116.0, 116.0, 117.0, 115.0, 119.0, 144.0, 115.0, 120.0], "value": 119.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 162.0, 162.0, 161.0, 162.0, 162.0, 174.0, 172.0, 168.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 75.0, 74.0, 86.0, 74.0, 75.0, 73.0, 74.0, 78.0], "value": 75.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 80.0, 82.0, 79.0, 79.0, 80.0, 78.0, 80.0, 80.0], "value": 79.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 115.0, 125.0, 114.0, 113.0, 114.0, 114.0, 113.0, 113.0], "value": 114.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 148.0, 147.0, 146.0, 148.0, 147.0, 148.0, 149.0, 149.0, 150.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 96.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 52.0, 52.0, 54.0, 55.0, 50.0, 50.0, 52.0, 51.0], "value": 52.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 39.0, 39.0, 39.0, 38.0, 38.0, 38.0, 39.0, 37.0, 38.0], "value": 38.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 78.0, 73.0, 77.0, 71.0, 76.0, 72.0, 73.0, 74.0], "value": 74.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 117.0, 121.0, 115.0, 111.0, 111.0, 113.0, 113.0, 110.0, 117.0], "value": 114.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 169.0, 168.0, 168.0, 170.0, 175.0, 166.0, 172.0, 168.0, 164.0], "value": 169.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 84.0, 65.0, 65.0, 70.0, 65.0, 64.0, 70.0, 65.0], "value": 68.1, "unit": "score"}]}]} 07:34:03 INFO - Return code: 0 07:34:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:34:03 INFO - # TBPL SUCCESS # 07:34:03 INFO - Running post-action listener: _package_coverage_data 07:34:03 INFO - Running post-action listener: _resource_record_post_action 07:34:03 INFO - [mozharness: 2017-09-21 14:34:03.205796Z] Finished run-tests step (success) 07:34:03 INFO - Running post-run listener: _resource_record_post_run 07:34:03 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 8192; Write bytes: 348901376; Read time: 16; Write time: 248196 07:34:03 INFO - TinderboxPrint: CPU usage
13.1% 07:34:03 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 16 07:34:03 INFO - TinderboxPrint: I/O write bytes / time
348,901,376 / 248,196 07:34:03 INFO - TinderboxPrint: CPU idle
8,229.7 (86.9%) 07:34:03 INFO - TinderboxPrint: CPU user
1,191.4 (12.6%) 07:34:03 INFO - TinderboxPrint: Swap in / out
0 / 0 07:34:03 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13414400; Read time: 0; Write time: 1256 07:34:03 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 07:34:03 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 0; Write bytes: 335486976; Read time: 0; Write time: 246940 07:34:03 INFO - Running post-run listener: _upload_blobber_files 07:34:03 INFO - Blob upload gear active. 07:34:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:34:03 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 07:34:03 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'] 07:34:03 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 07:34:04 INFO - (blobuploader) - INFO - Open directory for files ... 07:34:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 07:34:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:34:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:34:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 07:34:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:34:05 INFO - (blobuploader) - INFO - Done attempting. 07:34:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 07:34:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:34:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:34:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 07:34:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:34:06 INFO - (blobuploader) - INFO - Done attempting. 07:34:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:34:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:34:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:34:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:34:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:34:12 INFO - (blobuploader) - INFO - Done attempting. 07:34:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:34:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:34:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:34:13 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:34:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:34:13 INFO - (blobuploader) - INFO - Done attempting. 07:34:13 INFO - (blobuploader) - INFO - Iteration through files over. 07:34:13 INFO - Return code: 0 07:34:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:34:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:34:13 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f158f3b8c99255a4a26a70fca5c2d96aaad90b5fe786bcccdb615fff36572e61d9050d27db225affe02e9d02ff798d4eed1324f0820076340a989febf4f2305f", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7d86c997a20a8e4baea3b4ad1a4d335057f89d98622ac311baaa5d197ee01f43bf4721bf797ec0fb6e55a3361a92ebabe64a5bcd32606888033ff5e86c15d540", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1566393a8decaf21e82ef9a361bd0ba371e0c4b63c0017775c9b0d1b0d78891beb8116e720eda04cd0c34a9b7330abe405a93086636a3fe06f127658025440ff", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/acea190d1f4bc6a29bc0af115774f800f39e2a22907de73a7b5b525f75c76127c3e59d1fb88ab97394695c8d64b3a1ce6822e4e7cfcd5fc7c36a7c7413c7f0da"} 07:34:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:34:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:34:13 INFO - Contents: 07:34:13 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f158f3b8c99255a4a26a70fca5c2d96aaad90b5fe786bcccdb615fff36572e61d9050d27db225affe02e9d02ff798d4eed1324f0820076340a989febf4f2305f", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7d86c997a20a8e4baea3b4ad1a4d335057f89d98622ac311baaa5d197ee01f43bf4721bf797ec0fb6e55a3361a92ebabe64a5bcd32606888033ff5e86c15d540", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1566393a8decaf21e82ef9a361bd0ba371e0c4b63c0017775c9b0d1b0d78891beb8116e720eda04cd0c34a9b7330abe405a93086636a3fe06f127658025440ff", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/acea190d1f4bc6a29bc0af115774f800f39e2a22907de73a7b5b525f75c76127c3e59d1fb88ab97394695c8d64b3a1ce6822e4e7cfcd5fc7c36a7c7413c7f0da"} 07:34:13 INFO - Running post-run listener: copy_logs_to_upload_dir 07:34:13 INFO - Copying logs to upload dir... 07:34:13 INFO - mkdir: /builds/slave/test/build/upload/logs 07:34:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.836213 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-21 07:34:13.324793) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-21 07:34:13.333053) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1506003178.747299-300798062 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/f158f3b8c99255a4a26a70fca5c2d96aaad90b5fe786bcccdb615fff36572e61d9050d27db225affe02e9d02ff798d4eed1324f0820076340a989febf4f2305f", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7d86c997a20a8e4baea3b4ad1a4d335057f89d98622ac311baaa5d197ee01f43bf4721bf797ec0fb6e55a3361a92ebabe64a5bcd32606888033ff5e86c15d540", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1566393a8decaf21e82ef9a361bd0ba371e0c4b63c0017775c9b0d1b0d78891beb8116e720eda04cd0c34a9b7330abe405a93086636a3fe06f127658025440ff", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/acea190d1f4bc6a29bc0af115774f800f39e2a22907de73a7b5b525f75c76127c3e59d1fb88ab97394695c8d64b3a1ce6822e4e7cfcd5fc7c36a7c7413c7f0da"} build_url:https://queue.taskcluster.net/v1/task/OYLYgPYVTVKEo2gH9bptQA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011457 build_url: 'https://queue.taskcluster.net/v1/task/OYLYgPYVTVKEo2gH9bptQA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f158f3b8c99255a4a26a70fca5c2d96aaad90b5fe786bcccdb615fff36572e61d9050d27db225affe02e9d02ff798d4eed1324f0820076340a989febf4f2305f", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7d86c997a20a8e4baea3b4ad1a4d335057f89d98622ac311baaa5d197ee01f43bf4721bf797ec0fb6e55a3361a92ebabe64a5bcd32606888033ff5e86c15d540", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1566393a8decaf21e82ef9a361bd0ba371e0c4b63c0017775c9b0d1b0d78891beb8116e720eda04cd0c34a9b7330abe405a93086636a3fe06f127658025440ff", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/acea190d1f4bc6a29bc0af115774f800f39e2a22907de73a7b5b525f75c76127c3e59d1fb88ab97394695c8d64b3a1ce6822e4e7cfcd5fc7c36a7c7413c7f0da"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-21 07:34:13.364312) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 07:34:13.364631) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1506003178.747299-300798062 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-21 07:34:13.444512) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-21 07:34:13.447869) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-21 07:34:13.448189) ========= ========= Total master_lag: 1.81 =========