builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-011 starttime: 1506460885.95 results: success (0) revision: 7d15bc419c6cd7e9f3b4d41370c3b0e5990c8d1b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 14:21:25.951933) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 14:21:25.952333) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 14:21:25.952616) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 14:21:26.206168) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 14:21:26.206527) ========= 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=5cf47e208febbcd81da23b2e0000026f-1506459664.612733-1226596283 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-26 14:21:26-- 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% 223M=0s 2017-09-26 14:21:26 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127448 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 14:21:26.405190) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 14:21:26.405519) ========= 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=5cf47e208febbcd81da23b2e0000026f-1506459664.612733-1226596283 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020154 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 14:21:26.479145) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-09-26 14:21:26.479514) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7d15bc419c6cd7e9f3b4d41370c3b0e5990c8d1b --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 7d15bc419c6cd7e9f3b4d41370c3b0e5990c8d1b --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=5cf47e208febbcd81da23b2e0000026f-1506459664.612733-1226596283 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-26 14:21:26,559 truncating revision to first 12 chars 2017-09-26 14:21:26,559 Setting DEBUG logging. 2017-09-26 14:21:26,559 attempt 1/10 2017-09-26 14:21:26,559 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7d15bc419c6c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-26 14:21:27,231 attempt 1/10 2017-09-26 14:21:28,147 current task status: no status available at this point. state: STARTED 2017-09-26 14:21:28,148 sleeping for 9.00s (attempt 1/10) 2017-09-26 14:21:37,157 attempt 2/10 2017-09-26 14:21:37,789 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-09-26 14:21:37,981 unpacking tar archive at: mozilla-central-7d15bc419c6c/testing/mozharness/ program finished with exit code 0 elapsedTime=11.690077 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-09-26 14:21:38.193553) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 14:21:38.193929) ========= script_repo_revision: 7d15bc419c6cd7e9f3b4d41370c3b0e5990c8d1b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 14:21:38.194318) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 14:21:38.194616) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 14:21:38.218039) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-26 14:21:38.218385) ========= /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=5cf47e208febbcd81da23b2e0000026f-1506459664.612733-1226596283 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:21:38 INFO - MultiFileLogger online at 20170926 14:21:38 in /builds/slave/test 14:21:38 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 14:21:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:21:38 INFO - {'append_to_log': False, 14:21:38 INFO - 'base_work_dir': '/builds/slave/test', 14:21:38 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 14:21:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:21:38 INFO - 'branch': 'Firefox-Non-PGO', 14:21:38 INFO - 'buildbot_json_path': 'buildprops.json', 14:21:38 INFO - 'code_coverage': False, 14:21:38 INFO - 'config_files': ('talos/linux_config.py',), 14:21:38 INFO - 'default_actions': ('clobber', 14:21:38 INFO - 'read-buildbot-config', 14:21:38 INFO - 'download-and-extract', 14:21:38 INFO - 'populate-webroot', 14:21:38 INFO - 'create-virtualenv', 14:21:38 INFO - 'install', 14:21:38 INFO - 'setup-mitmproxy', 14:21:38 INFO - 'run-tests'), 14:21:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:21:38 INFO - 'disable_ccov_upload': False, 14:21:38 INFO - 'disable_stylo': False, 14:21:38 INFO - 'download_minidump_stackwalk': True, 14:21:38 INFO - 'download_symbols': 'ondemand', 14:21:38 INFO - 'enable_stylo': False, 14:21:38 INFO - 'enable_webrender': False, 14:21:38 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 14:21:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:21:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:21:38 INFO - 'gecko_profile': False, 14:21:38 INFO - 'gecko_profile_interval': 0, 14:21:38 INFO - 'installer_path': 'installer.exe', 14:21:38 INFO - 'log_level': 'info', 14:21:38 INFO - 'log_name': 'talos', 14:21:38 INFO - 'log_to_console': True, 14:21:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:21:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:21:38 INFO - 'opt_config_files': (), 14:21:38 INFO - 'pip_index': False, 14:21:38 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 14:21:38 INFO - 'system_bits': '32', 14:21:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:21:38 INFO - 'title': 'talos-linux64-ix-011', 14:21:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:21:38 INFO - 'use_talos_json': True, 14:21:38 INFO - 'verify': 'False', 14:21:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:21:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:21:38 INFO - 'work_dir': 'build'} 14:21:38 INFO - [mozharness: 2017-09-26 21:21:38.451463Z] Running clobber step. 14:21:38 INFO - Running pre-action listener: _resource_record_pre_action 14:21:38 INFO - Running main action method: clobber 14:21:38 INFO - rmtree: /builds/slave/test/build 14:21:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:21:39 INFO - Running post-action listener: _resource_record_post_action 14:21:39 INFO - [mozharness: 2017-09-26 21:21:39.433907Z] Finished clobber step (success) 14:21:39 INFO - [mozharness: 2017-09-26 21:21:39.434005Z] Running read-buildbot-config step. 14:21:39 INFO - Running pre-action listener: _resource_record_pre_action 14:21:39 INFO - Running main action method: read_buildbot_config 14:21:39 INFO - Using buildbot properties: 14:21:39 INFO - { 14:21:39 INFO - "project": "", 14:21:39 INFO - "product": "firefox", 14:21:39 INFO - "who": "kwierso@gmail.com", 14:21:39 INFO - "installer_path": "public/build/target.tar.bz2", 14:21:39 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 14:21:39 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 14:21:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 14:21:39 INFO - "stage_platform": "linux64", 14:21:39 INFO - "basedir": "/builds/slave/test", 14:21:39 INFO - "buildnumber": 70, 14:21:39 INFO - "platform": "ubuntu64_hw", 14:21:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:21:39 INFO - "slavebuilddir": "test", 14:21:39 INFO - "taskId": "JXl_wuGMTuyq4OpRPdLcOQ", 14:21:39 INFO - "branch": "mozilla-central", 14:21:39 INFO - "script_repo_revision": "production", 14:21:39 INFO - "revision": "7d15bc419c6cd7e9f3b4d41370c3b0e5990c8d1b", 14:21:39 INFO - "slavename": "talos-linux64-ix-011", 14:21:39 INFO - "repo_path": "mozilla-central" 14:21:39 INFO - } 14:21:39 INFO - Finding installer, test and symbols from parent task. 14:21:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JXl_wuGMTuyq4OpRPdLcOQ'}, attempt #1 14:21:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JXl_wuGMTuyq4OpRPdLcOQ'}, attempt #1 14:21:40 INFO - Task dependencies: DmeAWeThR7WU_DFoThmLQA 14:21:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DmeAWeThR7WU_DFoThmLQA'}, attempt #1 14:21:40 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/DmeAWeThR7WU_DFoThmLQA/artifacts/public/build/target.tar.bz2 14:21:40 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/DmeAWeThR7WU_DFoThmLQA/artifacts/public/build/target.test_packages.json 14:21:40 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/DmeAWeThR7WU_DFoThmLQA/artifacts/public/build/target.crashreporter-symbols.zip 14:21:40 INFO - Running post-action listener: _resource_record_post_action 14:21:40 INFO - [mozharness: 2017-09-26 21:21:40.909104Z] Finished read-buildbot-config step (success) 14:21:40 INFO - [mozharness: 2017-09-26 21:21:40.909321Z] Running download-and-extract step. 14:21:40 INFO - Running pre-action listener: _resource_record_pre_action 14:21:40 INFO - Running main action method: download_and_extract 14:21:40 INFO - mkdir: /builds/slave/test/build/tests 14:21:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:21:40 INFO - trying https://queue.taskcluster.net/v1/task/DmeAWeThR7WU_DFoThmLQA/artifacts/public/build/target.test_packages.json 14:21:40 INFO - Downloading https://queue.taskcluster.net/v1/task/DmeAWeThR7WU_DFoThmLQA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 14:21:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DmeAWeThR7WU_DFoThmLQA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 14:21:41 INFO - Downloaded 989 bytes. 14:21:41 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 14:21:41 INFO - Using the following test package requirements: 14:21:41 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 14:21:41 INFO - u'common': [u'target.common.tests.zip'], 14:21:41 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 14:21:41 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 14:21:41 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 14:21:41 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 14:21:41 INFO - u'mozbase': [u'target.common.tests.zip'], 14:21:41 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 14:21:41 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 14:21:41 INFO - u'web-platform': [u'target.common.tests.zip', 14:21:41 INFO - u'target.web-platform.tests.tar.gz'], 14:21:41 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 14:21:41 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 14:21:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DmeAWeThR7WU_DFoThmLQA/artifacts/public/build/target.common.tests.zip 14:21:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DmeAWeThR7WU_DFoThmLQA/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:21:41 INFO - Fetch https://queue.taskcluster.net/v1/task/DmeAWeThR7WU_DFoThmLQA/artifacts/public/build/target.common.tests.zip into memory 14:21:42 INFO - Content-Length response header: 54945059 14:21:42 INFO - Bytes received: 54945059 14:21:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DmeAWeThR7WU_DFoThmLQA/artifacts/public/build/target.talos.tests.zip 14:21:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DmeAWeThR7WU_DFoThmLQA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 14:21:53 INFO - Fetch https://queue.taskcluster.net/v1/task/DmeAWeThR7WU_DFoThmLQA/artifacts/public/build/target.talos.tests.zip into memory 14:21:54 INFO - Content-Length response header: 14513823 14:21:54 INFO - Bytes received: 14513823 14:21: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')]} 14:21:54 INFO - trying https://queue.taskcluster.net/v1/task/DmeAWeThR7WU_DFoThmLQA/artifacts/public/build/target.tar.bz2 14:21:54 INFO - Downloading https://queue.taskcluster.net/v1/task/DmeAWeThR7WU_DFoThmLQA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 14:21:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DmeAWeThR7WU_DFoThmLQA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 14:21:56 INFO - Downloaded 61630124 bytes. 14:21:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DmeAWeThR7WU_DFoThmLQA/artifacts/public/build/target.tar.bz2 14:21:56 INFO - mkdir: /builds/slave/test/properties 14:21:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:21:56 INFO - Writing to file /builds/slave/test/properties/build_url 14:21:56 INFO - Contents: 14:21:56 INFO - build_url:https://queue.taskcluster.net/v1/task/DmeAWeThR7WU_DFoThmLQA/artifacts/public/build/target.tar.bz2 14:21:56 INFO - Running post-action listener: _resource_record_post_action 14:21:56 INFO - Running post-action listener: find_tests_for_verification 14:21:56 INFO - Running post-action listener: set_extra_try_arguments 14:21:56 INFO - [mozharness: 2017-09-26 21:21:56.026301Z] Finished download-and-extract step (success) 14:21:56 INFO - [mozharness: 2017-09-26 21:21:56.026399Z] Running populate-webroot step. 14:21:56 INFO - Running pre-action listener: _resource_record_pre_action 14:21:56 INFO - Running main action method: populate_webroot 14:21:56 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:21:56 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:21:56 INFO - 'tests': ['tresize', 14:21:56 INFO - 'tcanvasmark']}, 14:21:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:21:56 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:21:56 INFO - 'tests': ['dromaeo_css', 14:21:56 INFO - 'kraken']}, 14:21:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:21:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:21:56 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:21:56 INFO - 'talos_options': ['--disable-stylo'], 14:21:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:21:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:21:56 INFO - 'tests': ['damp', 'tps']}, 14:21:56 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:21:56 INFO - 'talos_options': ['--disable-stylo'], 14:21:56 INFO - 'tests': ['damp', 'tps']}, 14:21:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:21:56 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:21:56 INFO - 'tests': ['dromaeo_dom']}, 14:21:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 14:21:56 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:21:56 INFO - 'tests': ['basic_compositor_video', 14:21:56 INFO - 'glvideo']}, 14:21:56 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 14:21:56 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 14:21:56 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:21:56 INFO - 'talos_options': ['--disable-stylo'], 14:21:56 INFO - 'tests': ['ts_paint_webext', 14:21:56 INFO - 'tp5o_webext']}, 14:21:56 INFO - 'other-e10s': {'tests': ['a11yr', 14:21:56 INFO - 'ts_paint', 14:21:56 INFO - 'tpaint', 14:21:56 INFO - 'sessionrestore', 14:21:56 INFO - 'sessionrestore_many_windows', 14:21:56 INFO - 'sessionrestore_no_auto_restore', 14:21:56 INFO - 'tabpaint']}, 14:21:56 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:21:56 INFO - 'tests': ['a11yr', 14:21:56 INFO - 'ts_paint', 14:21:56 INFO - 'tpaint', 14:21:56 INFO - 'sessionrestore', 14:21:56 INFO - 'sessionrestore_many_windows', 14:21:56 INFO - 'sessionrestore_no_auto_restore', 14:21:56 INFO - 'tabpaint']}, 14:21:56 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 14:21:56 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 14:21:56 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:21:56 INFO - 'tests': ['perf_reftest_singletons']}, 14:21:56 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:21:56 INFO - 'tests': ['perf_reftest']}, 14:21:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:21:56 INFO - 'tsvgr_opacity', 14:21:56 INFO - 'tart', 14:21:56 INFO - 'tscrollx', 14:21:56 INFO - 'tsvg_static']}, 14:21:56 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:21:56 INFO - 'tests': ['tsvgx', 14:21:56 INFO - 'tsvgr_opacity', 14:21:56 INFO - 'tart', 14:21:56 INFO - 'tscrollx', 14:21:56 INFO - 'tsvg_static']}, 14:21:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:21:56 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:21:56 INFO - 'talos_options': ['--disable-stylo'], 14:21:56 INFO - 'tests': ['tp5o']}, 14:21:56 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:21:56 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 14:21:56 INFO - 'talos_options': ['--mitmproxy', 14:21:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:21:56 INFO - '--firstNonBlankPaint'], 14:21:56 INFO - 'tests': ['tp6_google', 14:21:56 INFO - 'tp6_youtube', 14:21:56 INFO - 'tp6_amazon', 14:21:56 INFO - 'tp6_facebook']}, 14:21:56 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:21:56 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 14:21:56 INFO - 'talos_options': ['--disable-stylo', 14:21:56 INFO - '--mitmproxy', 14:21:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:21:56 INFO - '--firstNonBlankPaint'], 14:21:56 INFO - 'tests': ['tp6_google', 14:21:56 INFO - 'tp6_youtube', 14:21:56 INFO - 'tp6_amazon', 14:21:56 INFO - 'tp6_facebook']}, 14:21:56 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:21:56 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 14:21:56 INFO - 'talos_options': ['--stylo-threads=1', 14:21:56 INFO - '--mitmproxy', 14:21:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:21:56 INFO - '--firstNonBlankPaint'], 14:21:56 INFO - 'tests': ['tp6_google', 14:21:56 INFO - 'tp6_youtube', 14:21:56 INFO - 'tp6_amazon', 14:21:56 INFO - 'tp6_facebook']}, 14:21:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:21:56 INFO - 'talos_options': ['--xperf_path', 14:21:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:21:56 INFO - 'tests': ['tp5n']}, 14:21:56 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:21:56 INFO - 'talos_options': ['--disable-stylo', 14:21:56 INFO - '--xperf_path', 14:21:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:21:56 INFO - 'tests': ['tp5n']}}} 14:21:56 INFO - Running post-action listener: _resource_record_post_action 14:21:56 INFO - [mozharness: 2017-09-26 21:21:56.041914Z] Finished populate-webroot step (success) 14:21:56 INFO - [mozharness: 2017-09-26 21:21:56.042003Z] Running create-virtualenv step. 14:21:56 INFO - Running pre-action listener: _resource_record_pre_action 14:21:56 INFO - Running main action method: create_virtualenv 14:21:56 INFO - Creating virtualenv /builds/slave/test/build/venv 14:21:56 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:21:56 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 14:21:56 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 14:21:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:21:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:21:56 INFO - Installing distribute.............................................................................................................................................................................................done. 14:21:56 INFO - Installing pip...............done. 14:21:56 INFO - Return code: 0 14:21:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:21:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:21:57 INFO - Reading from file tmpfile_stdout 14:21:57 INFO - Output received: 14:21:57 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 14:21:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:21: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')]} 14:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21: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')]} 14:21:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf15b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ba9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7d60>, '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 0x10b8a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8ef0>, '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': '5cf47e208febbcd81da23b2e0000026f-1506459664.612733-1226596283', '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 14:21: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', 'pip>=1.5'] in /builds/slave/test/build 14:21: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 pip>=1.5 14:21:57 INFO - Using env: {'DISPLAY': ':0', 14:21:57 INFO - 'HOME': '/home/cltbld', 14:21:57 INFO - 'LANG': 'en_US.UTF-8', 14:21:57 INFO - 'LANGUAGE': 'en_US:en', 14:21:57 INFO - 'LOGNAME': 'cltbld', 14:21:57 INFO - 'MAIL': '/var/mail/cltbld', 14:21:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:57 INFO - 'MOZ_NO_REMOTE': '1', 14:21:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:21:57 INFO - 'NO_EM_RESTART': '1', 14:21:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:21:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:57 INFO - 'PWD': '/builds/slave/test', 14:21:57 INFO - 'SHELL': '/bin/bash', 14:21:57 INFO - 'SHLVL': '1', 14:21:57 INFO - 'TERM': 'linux', 14:21:57 INFO - 'TMOUT': '86400', 14:21:57 INFO - 'USER': 'cltbld', 14:21:57 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506459664.612733-1226596283', 14:21:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:57 INFO - '_': '/tools/buildbot/bin/python'} 14:21:58 INFO - Ignoring indexes: http://pypi.python.org/simple/ 14:21:58 INFO - Downloading/unpacking pip>=1.5 14:21:58 INFO - Running setup.py egg_info for package pip 14:21:58 INFO - warning: no files found matching 'pip/cacert.pem' 14:21:58 INFO - warning: no files found matching '*.html' under directory 'docs' 14:21:58 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 14:21:58 INFO - no previously-included directories found matching 'docs/_build/_sources' 14:21:58 INFO - Installing collected packages: pip 14:21:58 INFO - Found existing installation: pip 1.1 14:21:58 INFO - Uninstalling pip: 14:21:58 INFO - Successfully uninstalled pip 14:21:58 INFO - Running setup.py install for pip 14:21:58 INFO - warning: no files found matching 'pip/cacert.pem' 14:21:58 INFO - warning: no files found matching '*.html' under directory 'docs' 14:21:58 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 14:21:58 INFO - no previously-included directories found matching 'docs/_build/_sources' 14:21:58 INFO - Installing pip script to /builds/slave/test/build/venv/bin 14:21:58 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 14:21:58 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 14:21:58 INFO - Successfully installed pip 14:21:58 INFO - Cleaning up... 14:21:58 INFO - Return code: 0 14:21:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:21:58 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')]} 14:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:58 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')]} 14:21:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:58 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 0xd4d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf15b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ba9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7d60>, '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 0x10b8a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8ef0>, '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': '5cf47e208febbcd81da23b2e0000026f-1506459664.612733-1226596283', '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 14:21:58 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 14:21:58 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 14:21:58 INFO - Using env: {'DISPLAY': ':0', 14:21:58 INFO - 'HOME': '/home/cltbld', 14:21:58 INFO - 'LANG': 'en_US.UTF-8', 14:21:58 INFO - 'LANGUAGE': 'en_US:en', 14:21:58 INFO - 'LOGNAME': 'cltbld', 14:21:58 INFO - 'MAIL': '/var/mail/cltbld', 14:21:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:58 INFO - 'MOZ_NO_REMOTE': '1', 14:21:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:21:58 INFO - 'NO_EM_RESTART': '1', 14:21:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:21:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:58 INFO - 'PWD': '/builds/slave/test', 14:21:58 INFO - 'SHELL': '/bin/bash', 14:21:58 INFO - 'SHLVL': '1', 14:21:58 INFO - 'TERM': 'linux', 14:21:58 INFO - 'TMOUT': '86400', 14:21:58 INFO - 'USER': 'cltbld', 14:21:58 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506459664.612733-1226596283', 14:21:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:58 INFO - '_': '/tools/buildbot/bin/python'} 14:21:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:58 INFO - Downloading/unpacking psutil>=3.1.1 14:21: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 14:21: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 14:21: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 14:21: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 14:21:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:21:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:21:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:21:59 INFO - Installing collected packages: psutil 14:21:59 INFO - Running setup.py install for psutil 14:21:59 INFO - building 'psutil._psutil_linux' extension 14:21:59 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 14:21:59 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 14:21:59 INFO - building 'psutil._psutil_posix' extension 14:21:59 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 14:22:00 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 14:22:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:22:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:22:00 INFO - Successfully installed psutil 14:22:00 INFO - Cleaning up... 14:22:00 INFO - Return code: 0 14:22:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:22: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')]} 14:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22: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')]} 14:22:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf15b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ba9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7d60>, '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 0x10b8a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8ef0>, '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': '5cf47e208febbcd81da23b2e0000026f-1506459664.612733-1226596283', '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 14:22: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:22: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 mozsystemmonitor==0.3 14:22:00 INFO - Using env: {'DISPLAY': ':0', 14:22:00 INFO - 'HOME': '/home/cltbld', 14:22:00 INFO - 'LANG': 'en_US.UTF-8', 14:22:00 INFO - 'LANGUAGE': 'en_US:en', 14:22:00 INFO - 'LOGNAME': 'cltbld', 14:22:00 INFO - 'MAIL': '/var/mail/cltbld', 14:22:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:00 INFO - 'MOZ_NO_REMOTE': '1', 14:22:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:00 INFO - 'NO_EM_RESTART': '1', 14:22:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:00 INFO - 'PWD': '/builds/slave/test', 14:22:00 INFO - 'SHELL': '/bin/bash', 14:22:00 INFO - 'SHLVL': '1', 14:22:00 INFO - 'TERM': 'linux', 14:22:00 INFO - 'TMOUT': '86400', 14:22:00 INFO - 'USER': 'cltbld', 14:22:00 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506459664.612733-1226596283', 14:22:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:00 INFO - '_': '/tools/buildbot/bin/python'} 14:22:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:22: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 14:22: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 14:22: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 14:22: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 14:22:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:22:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:22:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:22:01 INFO - Installing collected packages: mozsystemmonitor 14:22:01 INFO - Running setup.py install for mozsystemmonitor 14:22:01 INFO - Successfully installed mozsystemmonitor 14:22:01 INFO - Cleaning up... 14:22:02 INFO - Return code: 0 14:22:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:22:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf15b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ba9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7d60>, '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 0x10b8a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8ef0>, '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': '5cf47e208febbcd81da23b2e0000026f-1506459664.612733-1226596283', '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 14:22:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:22:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:22:02 INFO - Using env: {'DISPLAY': ':0', 14:22:02 INFO - 'HOME': '/home/cltbld', 14:22:02 INFO - 'LANG': 'en_US.UTF-8', 14:22:02 INFO - 'LANGUAGE': 'en_US:en', 14:22:02 INFO - 'LOGNAME': 'cltbld', 14:22:02 INFO - 'MAIL': '/var/mail/cltbld', 14:22:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:02 INFO - 'MOZ_NO_REMOTE': '1', 14:22:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:02 INFO - 'NO_EM_RESTART': '1', 14:22:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:02 INFO - 'PWD': '/builds/slave/test', 14:22:02 INFO - 'SHELL': '/bin/bash', 14:22:02 INFO - 'SHLVL': '1', 14:22:02 INFO - 'TERM': 'linux', 14:22:02 INFO - 'TMOUT': '86400', 14:22:02 INFO - 'USER': 'cltbld', 14:22:02 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506459664.612733-1226596283', 14:22:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:02 INFO - '_': '/tools/buildbot/bin/python'} 14:22:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:02 INFO - Downloading/unpacking jsonschema==2.5.1 14:22: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 14:22: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 14:22: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 14:22: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 14:22:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:22:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:22: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 14:22: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 14:22: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 14:22: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 14:22:04 INFO - Downloading functools32-3.2.3-2.tar.gz 14:22:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:22:04 INFO - warning: no files found matching '*.txt' 14:22:04 INFO - no previously-included directories found matching 'build' 14:22:04 INFO - no previously-included directories found matching 'dist' 14:22:04 INFO - no previously-included directories found matching '.git*' 14:22:04 INFO - Installing collected packages: jsonschema, functools32 14:22:05 INFO - Running setup.py install for functools32 14:22:05 INFO - warning: no files found matching '*.txt' 14:22:05 INFO - no previously-included directories found matching 'build' 14:22:05 INFO - no previously-included directories found matching 'dist' 14:22:05 INFO - no previously-included directories found matching '.git*' 14:22:05 INFO - Successfully installed jsonschema functools32 14:22:05 INFO - Cleaning up... 14:22:05 INFO - Return code: 0 14:22:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:22: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')]} 14:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22: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')]} 14:22:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xd4d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf15b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ba9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7d60>, '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 0x10b8a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8ef0>, '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': '5cf47e208febbcd81da23b2e0000026f-1506459664.612733-1226596283', '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 14:22:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:22:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:22:05 INFO - Using env: {'DISPLAY': ':0', 14:22:05 INFO - 'HOME': '/home/cltbld', 14:22:05 INFO - 'LANG': 'en_US.UTF-8', 14:22:05 INFO - 'LANGUAGE': 'en_US:en', 14:22:05 INFO - 'LOGNAME': 'cltbld', 14:22:05 INFO - 'MAIL': '/var/mail/cltbld', 14:22:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:05 INFO - 'MOZ_NO_REMOTE': '1', 14:22:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:05 INFO - 'NO_EM_RESTART': '1', 14:22:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:05 INFO - 'PWD': '/builds/slave/test', 14:22:05 INFO - 'SHELL': '/bin/bash', 14:22:05 INFO - 'SHLVL': '1', 14:22:05 INFO - 'TERM': 'linux', 14:22:05 INFO - 'TMOUT': '86400', 14:22:05 INFO - 'USER': 'cltbld', 14:22:05 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506459664.612733-1226596283', 14:22:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:05 INFO - '_': '/tools/buildbot/bin/python'} 14:22:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:22:07 INFO - Cleaning up... 14:22:07 INFO - Return code: 0 14:22:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:22:07 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')]} 14:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:07 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')]} 14:22:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xd4d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf15b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ba9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7d60>, '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 0x10b8a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8ef0>, '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': '5cf47e208febbcd81da23b2e0000026f-1506459664.612733-1226596283', '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 14:22:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:22:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:22:07 INFO - Using env: {'DISPLAY': ':0', 14:22:07 INFO - 'HOME': '/home/cltbld', 14:22:07 INFO - 'LANG': 'en_US.UTF-8', 14:22:07 INFO - 'LANGUAGE': 'en_US:en', 14:22:07 INFO - 'LOGNAME': 'cltbld', 14:22:07 INFO - 'MAIL': '/var/mail/cltbld', 14:22:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:07 INFO - 'MOZ_NO_REMOTE': '1', 14:22:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:07 INFO - 'NO_EM_RESTART': '1', 14:22:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:07 INFO - 'PWD': '/builds/slave/test', 14:22:07 INFO - 'SHELL': '/bin/bash', 14:22:07 INFO - 'SHLVL': '1', 14:22:07 INFO - 'TERM': 'linux', 14:22:07 INFO - 'TMOUT': '86400', 14:22:07 INFO - 'USER': 'cltbld', 14:22:07 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506459664.612733-1226596283', 14:22:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:07 INFO - '_': '/tools/buildbot/bin/python'} 14:22:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:07 INFO - Downloading/unpacking blobuploader==1.2.4 14:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:08 INFO - Downloading blobuploader-1.2.4.tar.gz 14:22:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:22:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:22:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:08 INFO - Downloading docopt-0.6.1.tar.gz 14:22:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:22:09 INFO - Installing collected packages: blobuploader, requests, docopt 14:22:09 INFO - Running setup.py install for blobuploader 14:22:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:22:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:22:09 INFO - Running setup.py install for requests 14:22:09 INFO - Running setup.py install for docopt 14:22:09 INFO - Successfully installed blobuploader requests docopt 14:22:09 INFO - Cleaning up... 14:22:09 INFO - Return code: 0 14:22:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:22: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')]} 14:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22: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')]} 14:22:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:09 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 0xd4d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf15b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ba9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7d60>, '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 0x10b8a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8ef0>, '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': '5cf47e208febbcd81da23b2e0000026f-1506459664.612733-1226596283', '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 14:22:09 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 14:22:09 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 14:22:09 INFO - Using env: {'DISPLAY': ':0', 14:22:09 INFO - 'HOME': '/home/cltbld', 14:22:09 INFO - 'LANG': 'en_US.UTF-8', 14:22:09 INFO - 'LANGUAGE': 'en_US:en', 14:22:09 INFO - 'LOGNAME': 'cltbld', 14:22:09 INFO - 'MAIL': '/var/mail/cltbld', 14:22:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:09 INFO - 'MOZ_NO_REMOTE': '1', 14:22:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:09 INFO - 'NO_EM_RESTART': '1', 14:22:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:09 INFO - 'PWD': '/builds/slave/test', 14:22:09 INFO - 'SHELL': '/bin/bash', 14:22:09 INFO - 'SHLVL': '1', 14:22:09 INFO - 'TERM': 'linux', 14:22:09 INFO - 'TMOUT': '86400', 14:22:09 INFO - 'USER': 'cltbld', 14:22:09 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506459664.612733-1226596283', 14:22:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:09 INFO - '_': '/tools/buildbot/bin/python'} 14:22:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:22:09 INFO - Running setup.py (path:/tmp/pip-SANwbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:22:09 INFO - Running setup.py (path:/tmp/pip-HqJBvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:22:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:22:09 INFO - Running setup.py (path:/tmp/pip-efof1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:22:10 INFO - Running setup.py (path:/tmp/pip-L1jiwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:22:10 INFO - Running setup.py (path:/tmp/pip-FRubW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:22:10 INFO - Running setup.py (path:/tmp/pip-15PbnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:22:10 INFO - Running setup.py (path:/tmp/pip-CySsFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:22:10 INFO - Running setup.py (path:/tmp/pip-hYdwAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:22:10 INFO - Running setup.py (path:/tmp/pip-tryWij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:22:10 INFO - Running setup.py (path:/tmp/pip-5ufGvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:22:10 INFO - Running setup.py (path:/tmp/pip-vInAPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:22:10 INFO - Running setup.py (path:/tmp/pip-4jfJdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:22:10 INFO - Running setup.py (path:/tmp/pip-lagPxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:22:10 INFO - Running setup.py (path:/tmp/pip-8G5ewz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:22:10 INFO - Running setup.py (path:/tmp/pip-ukUkyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:22:10 INFO - Running setup.py (path:/tmp/pip-8i3Xu5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:22:10 INFO - Running setup.py (path:/tmp/pip-tWvauX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:22:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:22:11 INFO - Running setup.py install for manifestparser 14:22:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:22:11 INFO - Running setup.py install for mozcrash 14:22:11 INFO - Running setup.py install for mozdebug 14:22:11 INFO - Running setup.py install for mozdevice 14:22:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:22:11 INFO - Running setup.py install for mozfile 14:22:11 INFO - Running setup.py install for mozhttpd 14:22:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:22:11 INFO - Running setup.py install for mozinfo 14:22:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:22:11 INFO - Running setup.py install for mozInstall 14:22:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:22:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:22:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:22:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:22:11 INFO - Running setup.py install for mozleak 14:22:11 INFO - Running setup.py install for mozlog 14:22:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:22:12 INFO - Running setup.py install for moznetwork 14:22:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:22:12 INFO - Running setup.py install for mozprocess 14:22:12 INFO - Running setup.py install for mozprofile 14:22:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:22:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:22:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:22:12 INFO - Running setup.py install for mozrunner 14:22:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:22:12 INFO - Running setup.py install for mozscreenshot 14:22:12 INFO - Running setup.py install for moztest 14:22:12 INFO - Running setup.py install for mozversion 14:22:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:22:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:22:12 INFO - Cleaning up... 14:22:12 INFO - Return code: 0 14:22:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:22: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')]} 14:22:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22: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')]} 14:22:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:12 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 0xd4d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf15b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ba9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7d60>, '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 0x10b8a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8ef0>, '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': '5cf47e208febbcd81da23b2e0000026f-1506459664.612733-1226596283', '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 14:22:12 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 14:22:12 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 14:22:12 INFO - Using env: {'DISPLAY': ':0', 14:22:12 INFO - 'HOME': '/home/cltbld', 14:22:12 INFO - 'LANG': 'en_US.UTF-8', 14:22:12 INFO - 'LANGUAGE': 'en_US:en', 14:22:12 INFO - 'LOGNAME': 'cltbld', 14:22:12 INFO - 'MAIL': '/var/mail/cltbld', 14:22:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:12 INFO - 'MOZ_NO_REMOTE': '1', 14:22:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:12 INFO - 'NO_EM_RESTART': '1', 14:22:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:12 INFO - 'PWD': '/builds/slave/test', 14:22:12 INFO - 'SHELL': '/bin/bash', 14:22:12 INFO - 'SHLVL': '1', 14:22:12 INFO - 'TERM': 'linux', 14:22:12 INFO - 'TMOUT': '86400', 14:22:12 INFO - 'USER': 'cltbld', 14:22:12 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506459664.612733-1226596283', 14:22:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:12 INFO - '_': '/tools/buildbot/bin/python'} 14:22:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:22:12 INFO - Running setup.py (path:/tmp/pip-Ls6kZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:22:13 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)) 14:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:22:13 INFO - Running setup.py (path:/tmp/pip-RotC08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:22:13 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)) 14:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:22:13 INFO - Running setup.py (path:/tmp/pip-RJ0L4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:22:13 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)) 14:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:22:13 INFO - Running setup.py (path:/tmp/pip-n3pWig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:22:13 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)) 14:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:22:13 INFO - Running setup.py (path:/tmp/pip-glcLFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:22:13 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)) 14:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:22:13 INFO - Running setup.py (path:/tmp/pip-YtU32U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:22:13 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)) 14:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:22:13 INFO - Running setup.py (path:/tmp/pip-e1qmyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:22:13 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)) 14:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:22:13 INFO - Running setup.py (path:/tmp/pip-alPlum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:22:13 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)) 14:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:22:13 INFO - Running setup.py (path:/tmp/pip-2TutQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:22:13 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)) 14:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:22:13 INFO - Running setup.py (path:/tmp/pip-qxfVQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:22:13 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)) 14:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:22:13 INFO - Running setup.py (path:/tmp/pip-miJKMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:22:13 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)) 14:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:22:13 INFO - Running setup.py (path:/tmp/pip-PjHxqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:22:13 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)) 14:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:22:13 INFO - Running setup.py (path:/tmp/pip-zfwLMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:22:13 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)) 14:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:22:13 INFO - Running setup.py (path:/tmp/pip-4vZnQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:22:13 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)) 14:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:22:13 INFO - Running setup.py (path:/tmp/pip-lvJC2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:22:14 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)) 14:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:22:14 INFO - Running setup.py (path:/tmp/pip-FiPRC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:22:14 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)) 14:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:22:14 INFO - Running setup.py (path:/tmp/pip-nxcyjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:22:14 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)) 14:22:14 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)) 14:22:14 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)) 14:22:14 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)) 14:22:14 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)) 14:22:14 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)) 14:22:14 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)) 14:22:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:22:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:15 INFO - Downloading blessings-1.6.tar.gz 14:22:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:22:15 INFO - Installing collected packages: blessings 14:22:15 INFO - Running setup.py install for blessings 14:22:15 INFO - Successfully installed blessings 14:22:15 INFO - Cleaning up... 14:22:15 INFO - Return code: 0 14:22:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:22:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:22:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:22:15 INFO - Reading from file tmpfile_stdout 14:22:15 INFO - Current package versions: 14:22:15 INFO - argparse == 1.2.1 14:22:15 INFO - blessings == 1.6 14:22:15 INFO - blobuploader == 1.2.4 14:22:15 INFO - docopt == 0.6.1 14:22:15 INFO - functools32 == 3.2.3-2 14:22:15 INFO - jsonschema == 2.5.1 14:22:15 INFO - manifestparser == 1.1 14:22:15 INFO - mozInstall == 1.13 14:22:15 INFO - mozcrash == 1.0 14:22:15 INFO - mozdebug == 0.1 14:22:15 INFO - mozdevice == 0.51 14:22:15 INFO - mozfile == 1.2 14:22:15 INFO - mozhttpd == 0.7 14:22:15 INFO - mozinfo == 0.10 14:22:15 INFO - mozleak == 0.1 14:22:15 INFO - mozlog == 3.5 14:22:15 INFO - moznetwork == 0.27 14:22:15 INFO - mozprocess == 0.25 14:22:15 INFO - mozprofile == 0.28 14:22:15 INFO - mozrunner == 6.13 14:22:15 INFO - mozscreenshot == 0.1 14:22:15 INFO - mozsystemmonitor == 0.3 14:22:15 INFO - moztest == 0.8 14:22:15 INFO - mozversion == 1.4 14:22:15 INFO - psutil == 3.1.1 14:22:15 INFO - requests == 1.2.3 14:22:15 INFO - wsgiref == 0.1.2 14:22:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:22:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:15 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 0xd4d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf15b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ba9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7d60>, '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 0x10b8a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8ef0>, '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': '5cf47e208febbcd81da23b2e0000026f-1506459664.612733-1226596283', '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 14:22:15 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 14:22:15 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 14:22:15 INFO - Using env: {'DISPLAY': ':0', 14:22:15 INFO - 'HOME': '/home/cltbld', 14:22:15 INFO - 'LANG': 'en_US.UTF-8', 14:22:15 INFO - 'LANGUAGE': 'en_US:en', 14:22:15 INFO - 'LOGNAME': 'cltbld', 14:22:15 INFO - 'MAIL': '/var/mail/cltbld', 14:22:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:15 INFO - 'MOZ_NO_REMOTE': '1', 14:22:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:15 INFO - 'NO_EM_RESTART': '1', 14:22:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:15 INFO - 'PWD': '/builds/slave/test', 14:22:15 INFO - 'SHELL': '/bin/bash', 14:22:15 INFO - 'SHLVL': '1', 14:22:15 INFO - 'TERM': 'linux', 14:22:15 INFO - 'TMOUT': '86400', 14:22:15 INFO - 'USER': 'cltbld', 14:22:15 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506459664.612733-1226596283', 14:22:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:15 INFO - '_': '/tools/buildbot/bin/python'} 14:22:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:15 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)) 14:22:15 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)) 14:22:15 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)) 14:22:15 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)) 14:22:15 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)) 14:22:15 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)) 14:22:15 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)) 14:22:15 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)) 14:22:15 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)) 14:22:15 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 14:22:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:16 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 14:22:16 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 14:22:16 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 14:22:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 14:22:17 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)) 14:22:17 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)) 14:22:17 INFO - Installing collected packages: simplejson 14:22:17 INFO - Running setup.py install for simplejson 14:22:17 INFO - building 'simplejson._speedups' extension 14:22:17 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 14:22:18 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 14:22:18 INFO - Successfully installed simplejson 14:22:18 INFO - Cleaning up... 14:22:18 INFO - Return code: 0 14:22:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:22:18 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')]} 14:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:18 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')]} 14:22:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:18 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 0xd4d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf15b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ba9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7d60>, '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 0x10b8a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8ef0>, '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': '5cf47e208febbcd81da23b2e0000026f-1506459664.612733-1226596283', '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 14:22:18 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 14:22:18 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 14:22:18 INFO - Using env: {'DISPLAY': ':0', 14:22:18 INFO - 'HOME': '/home/cltbld', 14:22:18 INFO - 'LANG': 'en_US.UTF-8', 14:22:18 INFO - 'LANGUAGE': 'en_US:en', 14:22:18 INFO - 'LOGNAME': 'cltbld', 14:22:18 INFO - 'MAIL': '/var/mail/cltbld', 14:22:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:18 INFO - 'MOZ_NO_REMOTE': '1', 14:22:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:18 INFO - 'NO_EM_RESTART': '1', 14:22:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:18 INFO - 'PWD': '/builds/slave/test', 14:22:18 INFO - 'SHELL': '/bin/bash', 14:22:18 INFO - 'SHLVL': '1', 14:22:18 INFO - 'TERM': 'linux', 14:22:18 INFO - 'TMOUT': '86400', 14:22:18 INFO - 'USER': 'cltbld', 14:22:18 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506459664.612733-1226596283', 14:22:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:18 INFO - '_': '/tools/buildbot/bin/python'} 14:22:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:22:18 INFO - Cleaning up... 14:22:18 INFO - Return code: 0 14:22:18 INFO - Running post-action listener: _resource_record_post_action 14:22:18 INFO - Running post-action listener: _start_resource_monitoring 14:22:18 INFO - Starting resource monitoring. 14:22:18 INFO - [mozharness: 2017-09-26 21:22:18.509760Z] Finished create-virtualenv step (success) 14:22:18 INFO - [mozharness: 2017-09-26 21:22:18.510275Z] Running install step. 14:22:18 INFO - Running pre-action listener: _resource_record_pre_action 14:22:18 INFO - Running main action method: install 14:22:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:22:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:22:18 INFO - Reading from file tmpfile_stdout 14:22:18 INFO - Detecting whether we're running mozinstall >=1.0... 14:22:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:22:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:22:18 INFO - Reading from file tmpfile_stdout 14:22:18 INFO - Output received: 14:22:18 INFO - Usage: mozinstall [options] installer 14:22:18 INFO - Options: 14:22:18 INFO - -h, --help show this help message and exit 14:22:18 INFO - -d DEST, --destination=DEST 14:22:18 INFO - Directory to install application into. [default: 14:22:18 INFO - "/builds/slave/test"] 14:22:18 INFO - --app=APP Application being installed. [default: firefox] 14:22:18 INFO - mkdir: /builds/slave/test/build/application 14:22:18 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'] 14:22:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 14:22:36 INFO - Reading from file tmpfile_stdout 14:22:36 INFO - Output received: 14:22:36 INFO - /builds/slave/test/build/application/firefox/firefox 14:22:36 INFO - Running post-action listener: _resource_record_post_action 14:22:36 INFO - [mozharness: 2017-09-26 21:22:36.840790Z] Finished install step (success) 14:22:36 INFO - [mozharness: 2017-09-26 21:22:36.840935Z] Running setup-mitmproxy step. 14:22:36 INFO - Running pre-action listener: _resource_record_pre_action 14:22:36 INFO - Running main action method: setup_mitmproxy 14:22:36 INFO - Skipping: mitmproxy is not required 14:22:36 INFO - Running post-action listener: _resource_record_post_action 14:22:36 INFO - [mozharness: 2017-09-26 21:22:36.841464Z] Finished setup-mitmproxy step (success) 14:22:36 INFO - [mozharness: 2017-09-26 21:22:36.841790Z] Running run-tests step. 14:22:36 INFO - Running pre-action listener: _resource_record_pre_action 14:22:36 INFO - Running pre-action listener: _set_gcov_prefix 14:22:36 INFO - Running main action method: run_tests 14:22:36 WARNING - Try message not found. 14:22:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:22:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:22:36 INFO - Python 2.7.3 14:22:36 INFO - Return code: 0 14:22:36 INFO - grabbing minidump binary from tooltool 14:22: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')]} 14:22:36 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 0x10b7d60>, '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 0x10b8a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:22:36 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 14:22:36 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 14:22:36 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 14:22:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:22:36 INFO - Return code: 0 14:22:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:22:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:22:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:22:36 INFO - ENV: RUST_BACKTRACE is now full 14:22:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:22:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:22:36 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/DmeAWeThR7WU_DFoThmLQA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 14:22:36 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/DmeAWeThR7WU_DFoThmLQA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 14:22:36 INFO - Using env: {'DISPLAY': ':0', 14:22:36 INFO - 'HOME': '/home/cltbld', 14:22:36 INFO - 'LANG': 'en_US.UTF-8', 14:22:36 INFO - 'LANGUAGE': 'en_US:en', 14:22:36 INFO - 'LOGNAME': 'cltbld', 14:22:36 INFO - 'MAIL': '/var/mail/cltbld', 14:22:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:22:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:22:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:36 INFO - 'MOZ_NO_REMOTE': '1', 14:22:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:22:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:36 INFO - 'NO_EM_RESTART': '1', 14:22:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:36 INFO - 'PWD': '/builds/slave/test', 14:22:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:22:36 INFO - 'RUST_BACKTRACE': 'full', 14:22:36 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:22:36 INFO - 'SHELL': '/bin/bash', 14:22:36 INFO - 'SHLVL': '1', 14:22:36 INFO - 'TERM': 'linux', 14:22:36 INFO - 'TMOUT': '86400', 14:22:36 INFO - 'USER': 'cltbld', 14:22:36 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506459664.612733-1226596283', 14:22:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:36 INFO - '_': '/tools/buildbot/bin/python'} 14:22:36 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/DmeAWeThR7WU_DFoThmLQA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 14:22:37 INFO - mozversion application_buildid: 20170926203052 14:22:37 INFO - mozversion application_changeset: 7d15bc419c6cd7e9f3b4d41370c3b0e5990c8d1b 14:22:37 INFO - mozversion application_display_name: Nightly 14:22:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:22:37 INFO - mozversion application_name: Firefox 14:22:37 INFO - mozversion application_remotingname: firefox 14:22:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:22:37 INFO - mozversion application_vendor: Mozilla 14:22:37 INFO - mozversion application_version: 58.0a1 14:22:37 INFO - mozversion platform_buildid: 20170926203052 14:22:37 INFO - mozversion platform_changeset: 7d15bc419c6cd7e9f3b4d41370c3b0e5990c8d1b 14:22:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:22:37 INFO - mozversion platform_version: 58.0a1 14:22:37 INFO - using testdate: 1506460957 14:22:37 INFO - actual date: 1506460957 14:22:37 INFO - starting webserver on 'localhost:44478' 14:22:37 INFO - SUITE-START | Running 2 tests 14:22:37 INFO - TEST-START | dromaeo_css 14:22:37 INFO - Initialising browser for dromaeo_css test... 14:22:37 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44478/getInfo.html -profile /tmp/tmpux5rgm/profile 14:22:37 INFO - TEST-INFO | started process 4395 (/builds/slave/test/build/application/firefox/firefox http://localhost:44478/getInfo.html) 14:22:43 INFO - TEST-INFO | 4395: exit 0 14:22:43 INFO - Browser initialized. 14:22:43 INFO - Running cycle 1/1 for dromaeo_css test... 14:22:43 INFO - Using env: {'DISPLAY': ':0', 14:22:43 INFO - 'HOME': '/home/cltbld', 14:22:43 INFO - 'JSGC_DISABLE_POISONING': '1', 14:22:43 INFO - 'LANG': 'en_US.UTF-8', 14:22:43 INFO - 'LANGUAGE': 'en_US:en', 14:22:43 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 14:22:43 INFO - 'LOGNAME': 'cltbld', 14:22:43 INFO - 'MAIL': '/var/mail/cltbld', 14:22:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:22:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:22:43 INFO - 'MOZ_CRASHREPORTER': '1', 14:22:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:43 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 14:22:43 INFO - 'MOZ_NO_REMOTE': '1', 14:22:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:22:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:43 INFO - 'NO_EM_RESTART': '1', 14:22:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:43 INFO - 'PWD': '/builds/slave/test', 14:22:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:22:43 INFO - 'RUST_BACKTRACE': 'full', 14:22:43 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:22:43 INFO - 'SHELL': '/bin/bash', 14:22:43 INFO - 'SHLVL': '1', 14:22:43 INFO - 'STYLO_FORCE_DISABLED': '1', 14:22:43 INFO - 'TERM': 'linux', 14:22:43 INFO - 'TMOUT': '86400', 14:22:43 INFO - 'USER': 'cltbld', 14:22:43 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506459664.612733-1226596283', 14:22:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:43 INFO - '_': '/tools/buildbot/bin/python'} 14:22:43 INFO - TEST-INFO | started process 4634 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpux5rgm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:22:44 INFO - PID 4634 | 14:22:44 INFO - PID 4634 | (/builds/slave/test/build/application/firefox/firefox:4683): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:22:44 INFO - PID 4634 | 14:22:54 INFO - PID 4634 | RSS: Main: 151064576 14:22:54 INFO - PID 4634 | 14:25:52 INFO - PID 4634 | Cycle 1(1): loaded http://localhost:44478/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44478/tests/dromaeo/cssquery-ext.html) 14:25:53 INFO - PID 4634 | RSS: Main: 152379392 14:25:53 INFO - PID 4634 | 14:28:55 INFO - PID 4634 | Cycle 1(1): loaded http://localhost:44478/tests/dromaeo/cssquery-ext.html (next: http://localhost:44478/tests/dromaeo/cssquery-jquery.html) 14:28:56 INFO - PID 4634 | RSS: Main: 151760896 14:28:56 INFO - PID 4634 | 14:31:58 INFO - PID 4634 | Cycle 1(1): loaded http://localhost:44478/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44478/tests/dromaeo/cssquery-mootools.html) 14:31:58 INFO - PID 4634 | RSS: Main: 154112000 14:31:58 INFO - PID 4634 | 14:35:00 INFO - PID 4634 | Cycle 1(1): loaded http://localhost:44478/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44478/tests/dromaeo/cssquery-prototype.html) 14:35:00 INFO - PID 4634 | RSS: Main: 153161728 14:35:00 INFO - PID 4634 | 14:38:04 INFO - PID 4634 | Cycle 1(1): loaded http://localhost:44478/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44478/tests/dromaeo/cssquery-yui.html) 14:38:04 INFO - PID 4634 | RSS: Main: 154165248 14:38:04 INFO - PID 4634 | 14:41:06 INFO - PID 4634 | Cycle 1(1): loaded http://localhost:44478/tests/dromaeo/cssquery-yui.html (next: http://localhost:44478/tests/dromaeo/cssquery-dojo.html) 14:41:06 INFO - PID 4634 | RSS: Main: 156475392 14:41:06 INFO - PID 4634 | 14:41:06 INFO - PID 4634 | __start_tp_report 14:41:06 INFO - PID 4634 | _x_x_mozilla_page_load 14:41:06 INFO - PID 4634 | _x_x_mozilla_page_load_details 14:41:06 INFO - PID 4634 | |i|pagename|runs| 14:41:06 INFO - PID 4634 | |0;dojo.html;3139.874405023799;3157.6210854697424;3170.968290317096;3187.7927934684258;3193.0580478758766;6161.476274516672;6215.067739839015;6243.594166379188;6333.873322533553;6350.555461117718;6231.844203894893;6248.84377890553;6267.37326267373;6290.308066112735;6331.4618257448055;5827.533797296227;5868.2664666916635;5870.442307980735;5919;5945.346011938684;1253.3469307568864;5718.59969802114;5832.854178645525;5852.573406552847;5932.7330270137945;5359;5699;5814.505767009767;5815.941840581582;5843.64938103713;5786.5370770338695;5796.82609521715;5890.646561206298;5893.616914900561;5895.292564892197;5745.2818397700285;5756.222909907151;5817.127430885359;5833.912491312633;5834.737436815353;6203.96898015507;6263.31103578606;6317.1156038154695;6346.682665866734;6419.679016049179;6547.9345206547805;6701.1623547056615;6717.294684058153;6768.255491895888;6868.828279293008;6826.863462730717;6831.760888368884;6838.316168383171;6844.828879278008;6925.168979722465;6266.5926714763855;6282.78010269643;6364.013577895434;6364.236291644986;6405.167328247298;7007.054047703597;7011.404030657452;7016.052832867497;7077.256888026786;7098.538594991309;6458.773942912069;6591.604503729792;6596.934030659728;6603.834904127435;6604.3725846044545;6694.9665251674405;6716;6794.864102717918;6811.863762724718;6815.045893574904;6667.599944003376;6815.965920170367;6831.69257383409;6833.180018397725;6837.418819400307;6790.11728475305;6791.456683465311;6872.037914691947;6878.828029299308;6892.483063770237;5187.4553171916405;5291.894162116813;5336.306280183629;5406.513413792777;5409.350877894599;4571.405717256802;4662.230731929194;4705.7411842349;4719.693219940693;4721.15019296523;5791.102379131242;5839.357670656224;5867.61860479076;5871.060630299132;5879.382664820132;6720.2943690912725;6754.5947243165565;6844.5208835382045;6856.451483881277;6867.313268673192;5683.318001839806;5710;5787.421257874179;5789.710514474259;5850.824475265749;5844.707764611752;5848.766049357978;5859.2382990211;5889.823305300848;5891.381404952418;6474.255460621995;6479.125318082093;6555.246146693096;6564.015397690289;6648.567843090281;6562.606243625398;6696.19645642526;6810.795676129724;6903.861922761617;6910.585364878123;6449.6130232186215;6491.902621460777;6493.415592596689;6501.772437964649;6516.674166291572;6618.6690665467495;6709.161354830646;6741.797746067626;6746.089277947414;6764.188297404343;6710.865782684416;6822.488313376616;6866;6871.587704737732;6875.968604709334;6380;6497;6539.6403197824575;6553.606783593;6643.900341494785;6454.870902581828;6464.030395440722;6489.772857949949;6495.9025614614875;6561.1470508835455;6469.708863101077;6519.576227545194;6537.477001839937;6558.57369271015;6593.208814942238;6515.250746164252;6639.634820084942;6701.430378417694;6725.19297684281;6737.797866064026;6278.780242691484;6373.362663733589;6412;6485.027245912962;6488.870222595616 14:41:06 INFO - PID 4634 | |1;ext.html;853.4623187391946;887.2325438495701;889.3680097021972;908.1372695938855;911.8176364727054;40601;41287;41368.37947430791;41438;41492.792536037276;36368.09079773007;36538.451923221175;36878.44682329761;36925.630743692556;36980.81509592448;7054.894176587355;7221.350078492935;7244.71021159153;7246.311600397954;7246.528975616595;7173.10336207974;7208.9639551802165;7214.062171917643;7248.637568121573;7257.346838784509;7618.923810761905;7863.13505514393;7871.448998570074;7873.330766884822;7874.97625308709;7754.728584499544;7778.727744528971;7780.533168009909;7782.688692452295;7815;7622.123455802598;7767.417443691746;7842.254985776342;7856.607169641495;7867.252611001945;37673.81163094194;37754.62245377539;38071;38093.23813523714;38128;3525.048236976028;3577.83899724513;3579.284143171376;3585.1933315004176;3585.265020670782;30953.690463095307;30986;31160.844195779104;31173.532397014063;31185.22036949072;5066.949330506684;5101.897962040775;5110.66780659256;5154.252633368178;5156.278121063054;185214;187636;188244.99999999863;188507;188688.05655971632;47843.76078119587;48118;48140.518594813606;48300.5169948296;48457.515424846;50243.24635130476;50256.24615630769;50256.24615630769;50416.747916260916;50503.747481262355;16263.18684065792;16567.840251182544;16569.502914912573;16581.25384357707;16588.08765517884;13595.864041359657;13600.863991360158;13609.11540749848;13632.522861699794;13650.931745341408;13904.51334203298;14145.363458644386;14226;14231.928840355939;14369.856301437061;5660.264165658438;5739.85650358736;5798.680527788918;5808.514891065412;5822.854428639318;997.0976266478848;998.9850152247722;1022.1260821997085;1028.9897101029044;1036.160709825029;22625.54748905013;22672.886635566716;23078.192263270706;23120.4219894504;23150.1897433589;1075.5106426576046;1080;1099.9725006874892;1112.5883423133491;1113.3097479562562;12064.819027714591;12115.454804533818;12141.635750927486;12143.514259429701;12170.81743773844;214809;217028;217497;217796;218176;50345.24482132771;50809.237861432106;50833.74583127061;50983.235251471255;53593.46406535885;1416.9149851008767;1446.8770154536983;1449.0943160524673;1456.8033315502485;1458.2562892924684;26493.33766655849;26883.596746049217;26890.86554567293;27319.86340068287;27628.585571216045;37344.43983340198;37650.43524347192;37779;37814.2437151261;37825.81087094547;187158;187495.0625246865;187529;188587;188850.05574972037;33226.83386583148;33956.15109622279;34028.149296267795;34211.4868276981;34263;40644;41459;41463;41535.169296614506;41614.58385416107;30602.234944125685;30927.226819329695;31282.497400208384;31518.684813151576;31928.52107218347;30607.693923061375;30946;31046.689533105284;31178;31906.20234494156;33429;34934.47598285977;34942;34971.825140874134;35114.297714046086;30538.84730576422;30813.845930770203;30918.227044323172;31276.218094547818;31374.215644609067;22481;22667.88666056659;22694.546109078055;23009;23135.768642314033 14:41:06 INFO - PID 4634 | |2;jquery.html;572.4189947203589;591.0985746736229;598.6677394046305;601.7292218501675;603.1766638538395;21939.122435102596;22771.772282277172;22773.31680049601;22799.202027929026;22840.88579557102;20079.498012549695;20315.288964886196;21957.780422195774;24630.384240394;24778;6364.713587888545;6530.8040758777315;6536.836579085513;6544.770933017346;6546;6411.326810684881;6529.738810447577;6535.281119076922;6837.829054273658;7124.216336203013;7064.25825288345;7129.964350178242;7130.786076417689;7133.57198568085;7152.606606636633;6828.351306625863;7087.362137407632;7104.573725576456;7132.2867713228525;7160.462965277573;7019.473539484508;7051.224365319811;7056.15326160864;7058.858822823566;7081.468889833283;30207.848960755276;30982.535261970865;31080;31131;31137.688623113707;2144.8176904963098;2158.5467051919118;2170.435686721448;2170.913163473459;2171.685105659686;19457.805421945883;19478.220871165136;19838.305659302;19959.50101247466;19991.40025799228;2507.9373015674573;2541.9237422877345;2598.2724837045657;2614.3856193794445;2617.764401203901;128415;133430;137105.31447342798;146099;146675.26662366727;19320.42038738812;19698.340724002363;20402.38792836217;21501.56996860054;21578.676319855214;42028.78985605114;42463;42548.57451425508;42623.14753704909;42738.57261427408;10732.946335268274;10822.673125278103;10887.237893347548;10930.726731831608;10941.671749847517;8757.386982911263;8855.867161992446;8892.110788921056;8918.910810891808;8950.776230594287;10766;11023.17326200538;11316.6039188628;11409.315441073562;11539.884601154048;3624.5469316335457;3842.135519508144;3853.96146038536;4305.763183024964;4498.190325741398;961.2118063188259;977.7702239973601;983.7294743945472;993.6025589764008;994.3487016004528;18555.35056273024;18747.34384296543;19024.90487547581;19242.71135932962;19514.12186451613;1040.0431602925328;1043.2905624175633;1047.779966207105;1051.6792378324685;1058.402002868377;10428.270021098602;10621.787564248672;10648.893511064945;10656.840147397796;10709.678709638723;504209;507005;509519;516565;520735;114546;114587;114629.4268528652;116805;118019;1054.6888667843004;1091.645215305029;1099.378850949211;1144.376314908377;1175.735459521618;19495.220191192195;19510.60978780445;19834;19892.60214795725;20371.59256814885;56419;56533.71733141308;56560.43439565552;56564.15153772779;58040.4195958035;69163.30836691569;69196.30803691898;69269;69272.6536367315;70876.64561677158;18941.43175704731;19602.411927642195;19641.705374419682;19735.11191996335;19847;22120;22244.332670019925;22381.88809055944;22403.77596224082;22593.322200334016;17745.911270443565;18065.819341806415;18262.817371826644;18264.634707305515;18277.908610456863;14470.782938255725;15028.549143525712;15060.322285496959;15295.77056344178;15866.841331586536;18217.45347639573;18232.81767182311;18233.81766182374;18571.350002749838;18582.44252672422;19147.13837877271;19258.325958591384;19260.711089333952;19324.516887077374;19459.610807784047;17696.469105926844;17704;17900.820991789915;17918.5520361992;18044.90977545104 14:41:06 INFO - PID 4634 | |3;mootools.html;1333.3133436280314;1396.9511067112646;1414.3564678071477;1425.5367005723135;1431.3916585451186;15788.210589470524;16282.185890705461;16334.428295009677;16335.428260010902;16346.34614615414;15886.046837189777;16085.758713619305;16101.597460063504;16101.83898161018;16114;2771.196353057611;2833.2067021234034;2833.744962953334;2842.7725781937497;2857.7999540032206;2804;2809.35384861482;2812.2406950123454;2829.7170282971742;2833.5607980763016;2745.7803375729895;2773.1680495851165;2853.058490698065;2857.785666075042;2858.2425657200856;2802.8038037337396;2833.659960804696;2837.1488553433887;2838.3188034871587;2854.5147324954805;2650.2314328844614;2765.9308517287227;2778.763805076571;2832.433513297349;2836.4752520783513;15386.538403847902;15427.845721542753;15462.922685386613;15506.069635821887;15528.145951972638;7858.09631892334;8095.838083238361;8153.633086511121;8158.143394943564;8163.061247956502;5359.791833856173;5400;5565.443455654443;5566.944330556683;5591.916121258185;2016.0927582587894;2022.5247066939257;2039.2149022626247;2089.958200835975;2095.078165607143;26168.084117056;26362.94548218069;26619.600705989425;26627.600585991226;26651.46697066048;6729.899051514231;6843.178818541707;6926.515143939977;7145.821354466076;7175.605341706152;17504.38734644307;17628.030458324916;17644.558886027953;17663.11684415774;17670.823291767174;8034.317083047889;8107.878381824277;8200.548969806718;8216.958915205505;8225.054118776417;7379.926200738031;7412.592307423143;7554.773356799305;7556.546607203585;7577.659005344773;5254.343207099113;5381.596380271495;5416.160495123262;5443.972780136074;5467.972660136674;1609.2999545197877;1610.6617610301732;1611.1541440743704;1616.8383161683973;1635.623806524506;890.5547226386807;901.0898992017978;903.4895284164426;918.1736437206567;918.490237917962;7314.743983960642;7540.3213710766295;7558.168601453835;7573.886391704129;7614.428917831185;708.3943228539524;738.3059923671732;743.5427212264526;757.8560073586001;762.7063580521428;4633.745144017044;4988.9750551247735;5132.153194722903;5185.896282074337;5350.3312085989255;21648;22574.322770316918;22676.546469070527;22773.202937897095;22773.544529109324;21067.8946605266;22193.667094993587;22262.666060009113;22455.32634020982;22495.550088998127;11400.543978240943;11590.188686791844;11590.420478976017;11608.941955290169;11643.941780290876;7740;7874.921250787419;7955.801104972422;7984.321332686786;8093.959530202312;18401.90799045996;18775.34286299973;18795.436136915916;18826.52933676669;18913.905430472758;19591.118399671763;19664.41006769799;19724.211031558578;19779.307724229584;20297;11444.885551144715;11563.88436115628;11669.88330116688;11670.124740644316;11685.707857303636;14068.859311406755;14136.575902722934;14190.858091418953;14307.856921431068;14322.427102916183;11041;11047.83428248593;11070.557177713123;11229.27009744364;11308.830367544659;10578.629747958785;11139.777204456028;11181.832272515756;11338.546458141582;11465.082793376343;9790.46152461593;9957.103860652576;9976.650817221362;10026.598936042477;10110.039546243095;7385.667644955883;7511.436642251962;7520.511166774361;7542.962285188539;7570.659320330488;7550.395968322411;7567.9243207569425;7621.31408173267;7673;7737.187595302637 14:41:06 INFO - PID 4634 | |4;prototype.html;521.4212224430881;523.8009556368577;546.2461802712257;546.2707285773497;547.31312203185;6163.59936604121;6261.780837670683;6333.651649159295;6391.968040159799;6409.455196308313;6233.40782625651;6256.311805701369;6313.453203965035;6320.027573942626;6367.904481432783;5238.659487133344;5271.808911915017;5273.129933560977;5300.284461597693;5340.1576456122575;5226.876221612352;5252.579793616521;5257.158854583267;5348.893022139555;5356.303680521527;5292.338457692788;5348.171033489796;5351.839444816662;5369.221462887879;5381;5282.339707536558;5290.39160496544;5297.443768404339;5327.733613319358;5353.464653534655;4965.478624744422;4988.775505102279;5054.974725126388;5055.848324550233;5062.949370506285;6385.393387628214;6393.6163830170335;6401.199850018747;6422.197225346832;6429;6094.421030002142;6110.327863934964;6181.536384771161;6201.6899155042065;6203.472704820096;6690.498212634072;6722.83192920176;6744.966275168642;6770.458363330922;6774.254831968528;5423.234150583192;5424.430434804328;5460.890782184334;5472.753726082336;5503.284573005523;7022.068931044004;7089.539179953338;7105.253948335402;7185.856282874365;7211.639418029077;5568.721563921868;5579.38626751057;5632.549396048306;5634.774609015675;5635.154726790932;5693.857653558694;5722.37053924068;5757.798477053283;5758.798442054592;5764.596478246483;6140.2017737694705;6168.35232300602;6219.7249563839305;6225.844353891099;6227.20140714164;6505.512086593524;6703.229128650268;6794;6839.658017099126;6902.965485172542;1822.4532640207885;1881.9623607528047;1941.0977242302622;1960.9509762256057;1974.7729011163613;1441.0921119694526;1442.9422823087168;1459.6496840758355;1476.2618690654672;1487.970240595182;5599.328080630269;5713.74288157034;5725.713714314267;5803.448672376117;5835.2122463466885;6719.966400168066;6725.798226053226;6744.527883048139;6820.147481564804;6855.760048398282;5734.426557344315;5769.798057067983;5788.787223091141;5796.188533605298;5829;3540.73444491659;3544.5923718772156;3590.9640903591153;3648.7445878788762;3661.6521430464063;6422.100905873182;6482.661429363881;6528.412442880163;6575.309592492719;6674.466042716571;6810.693518791666;6831.795046148623;6951.930480695129;6993.825154371079;7032.648367581601;6487.902681459782;6582.873135260713;6602.504812139109;6612.6032438054835;6667.499937504804;6736.696848641921;6794.524383293122;6804.727810887509;6911.373678002327;6933.5493192942295;6688;6722.9663851680425;6763.6618169092335;6837.829054273683;6848.794536163923;6537.378948999837;6574.474042076718;6621.656063687999;6705.597664140168;6717.429018533479;5175.120229561059;5193.221016847503;5193.896122077462;5217.869553261199;5223.503767142115;6588.670566471753;6859.622720750406;6898.172219333512;6916.481263905328;6985.1967023790885;6505.902411463737;6682.665866706548;6686.796376652249;6700.626371593909;6705.966470167618;6684.665766711742;6689.76585819494;6697.162854643169;6713.597184168965;6725.9663701681175;6484.5460817742305;6563.540552161494;6601.504887133388;6625.271220165874;6648.966755166193;6711.738046340706;6788.355106264897;6793.966030169818;6822.692978816064;6839.487038472234;6340.700156468005;6358.682065896594;6365.331640177715;6440.967795160994;6449.3873082057125 14:41:06 INFO - PID 4634 | |5;yui.html;874.5670892908007;891.5007595746387;897.6454300551283;902.9548522573874;923.9399439036464;18142.727859082108;19131.330403435866;19173.616527669437;19215.903920480396;19221.1350489228;17506.649867002652;17555.297788088494;17655.20551575179;17673.116344182803;17811;926.6061923682441;941.5668792355491;949.3876449689946;953.1469334945219;954.4798085043633;971.3200759468365;974.0892265731528;975.2149519636689;975.7267964969819;977.5991843344231;980.6763767956558;1017.3285631483222;1026.4457193115709;1027.6968294353185;1030.9072183503483;1013.2350075692879;1018.6536577563589;1018.816613009658;1019.0115587879782;1022.4223313827664;722.443718336883;737.0602481835649;738.8780851159552;739.3087463221905;741.6551303643831;17359.479215623553;17592.12039398025;17614.559636009075;17651.55871103233;17695.115244237735;21621.67567486489;21910.342689719175;21951.780482195292;22106;22301.21945731908;16223.51329460118;16318.836811631969;16509.58726031859;16514.6697066058;16829.91585042079;3642.690371318441;3670.834812433447;3678.5401824771902;3679.6504332088675;3681.9631803681887;108539.45730271377;136152;141600;142140;149480.25259873632;16887.408940687015;17273.56816079583;17370.3051877926;17480.91259543694;17485.213165407586;32193.35613287768;32521.674783251863;32632.184195395304;32682;32697.50953735696;9118.908810911938;9189.954050229706;9316.208122309545;9331.766705832273;9339.766505837273;4236.724612900151;4304.16068866568;4304.892377690583;4307.612314891675;4324.286492728665;5366.517013468807;5448.863778405572;5484.067708489566;5486;5491.395946445888;1065.8454524094118;1069.235496619905;1091.045335331585;1091.7598128411737;1094.124700239805;685.2188505104185;702.880510313248;706.2549010793662;710.6304721544768;715.0204220218334;12204.816927746091;12297.262164270172;12620.684482888002;12963.805542916863;13096.148750331198;675.3280485916447;675.4258879952001;677.806825054857;689.4449967775888;689.899964505144;5719.3422756382715;5766.279215098113;5803.332616749043;5818.214541036906;5888.440598143169;124417;125926;128718;128796;130264;88090.55954720185;93577;104142.47928760308;106343;115677.42161289309;89632.5518372417;93057;94283.52858235665;94649;99067;11904.166708330335;12179.75640487203;12206.389680516117;12238.877611223774;12318.75362492763;42377;44590.77704611456;45075.549244507136;45272.547274526834;46078.53921460742;57817.4218257812;57906;57965.420345796;58587.70706146442;60426.395736043836;18896;19149.617007660047;19255.422337329903;19378.321758738377;19416.126274317972;21045.579088418453;21298.36104916855;21595.460113497287;21650.67523987173;21704.782952170277;19452.610947780682;19855.205791768745;19871.105800238736;19880;19969.500762481053;18531.44405667832;18992.335268265546;19038.524036899187;19148.234070637576;19238.71141932844;19114.23543058262;19468.513287167934;19526;19657.311994080137;19863;13078.607641770763;13206.141600795918;13286.601401957956;13512.256825874278;13536.59390218295;13861.653458663613;13974.30128493551;14155.221462819232;14182.92908535492;14216 14:41:06 INFO - PID 4634 | __end_tp_report 14:41:06 INFO - PID 4634 | __start_cc_report 14:41:06 INFO - PID 4634 | _x_x_mozilla_cycle_collect,273 14:41:06 INFO - PID 4634 | __end_cc_report 14:41:06 INFO - PID 4634 | __startTimestamp1506462066842__endTimestamp 14:41:06 INFO - PID 4634 | 14:41:06 INFO - PID 4634 | ------- Summary: start ------- 14:41:06 INFO - PID 4634 | Number of tests: 6 14:41:06 INFO - PID 4634 | 14:41:06 INFO - PID 4634 | [#0] dojo.html Cycles:165 Average:6193.33 Median:6464.03 stddev:842.43 (13.0%) stddev-sans-first:810.24 14:41:06 INFO - PID 4634 | Values: 3139.9 3157.6 3171.0 3187.8 3193.1 6161.5 6215.1 6243.6 6333.9 6350.6 6231.8 6248.8 6267.4 6290.3 6331.5 5827.5 5868.3 5870.4 5919.0 5945.3 1253.3 5718.6 5832.9 5852.6 5932.7 5359.0 5699.0 5814.5 5815.9 5843.6 5786.5 5796.8 5890.6 5893.6 5895.3 5745.3 5756.2 5817.1 5833.9 5834.7 6204.0 6263.3 6317.1 6346.7 6419.7 6547.9 6701.2 6717.3 6768.3 6868.8 6826.9 6831.8 6838.3 6844.8 6925.2 6266.6 6282.8 6364.0 6364.2 6405.2 7007.1 7011.4 7016.1 7077.3 7098.5 6458.8 6591.6 6596.9 6603.8 6604.4 6695.0 6716.0 6794.9 6811.9 6815.0 6667.6 6816.0 6831.7 6833.2 6837.4 6790.1 6791.5 6872.0 6878.8 6892.5 5187.5 5291.9 5336.3 5406.5 5409.4 4571.4 4662.2 4705.7 4719.7 4721.2 5791.1 5839.4 5867.6 5871.1 5879.4 6720.3 6754.6 6844.5 6856.5 6867.3 5683.3 5710.0 5787.4 5789.7 5850.8 5844.7 5848.8 5859.2 5889.8 5891.4 6474.3 6479.1 6555.2 6564.0 6648.6 6562.6 6696.2 6810.8 6903.9 6910.6 6449.6 6491.9 6493.4 6501.8 6516.7 6618.7 6709.2 6741.8 6746.1 6764.2 6710.9 6822.5 6866.0 6871.6 6876.0 6380.0 6497.0 6539.6 6553.6 6643.9 6454.9 6464.0 6489.8 6495.9 6561.1 6469.7 6519.6 6537.5 6558.6 6593.2 6515.3 6639.6 6701.4 6725.2 6737.8 6278.8 6373.4 6412.0 6485.0 6488.9 14:41:06 INFO - PID 4634 | 14:41:06 INFO - PID 4634 | [#1] ext.html Cycles:180 Average:36567.07 Median:34956.91 stddev:51185.95 (146.4%) stddev-sans-first:51259.29 14:41:06 INFO - PID 4634 | Values: 853.5 887.2 889.4 908.1 911.8 40601.0 41287.0 41368.4 41438.0 41492.8 36368.1 36538.5 36878.4 36925.6 36980.8 7054.9 7221.4 7244.7 7246.3 7246.5 7173.1 7209.0 7214.1 7248.6 7257.3 7618.9 7863.1 7871.4 7873.3 7875.0 7754.7 7778.7 7780.5 7782.7 7815.0 7622.1 7767.4 7842.3 7856.6 7867.3 37673.8 37754.6 38071.0 38093.2 38128.0 3525.0 3577.8 3579.3 3585.2 3585.3 30953.7 30986.0 31160.8 31173.5 31185.2 5066.9 5101.9 5110.7 5154.3 5156.3 185214.0 187636.0 188245.0 188507.0 188688.1 47843.8 48118.0 48140.5 48300.5 48457.5 50243.2 50256.2 50256.2 50416.7 50503.7 16263.2 16567.8 16569.5 16581.3 16588.1 13595.9 13600.9 13609.1 13632.5 13650.9 13904.5 14145.4 14226.0 14231.9 14369.9 5660.3 5739.9 5798.7 5808.5 5822.9 997.1 999.0 1022.1 1029.0 1036.2 22625.5 22672.9 23078.2 23120.4 23150.2 1075.5 1080.0 1100.0 1112.6 1113.3 12064.8 12115.5 12141.6 12143.5 12170.8 214809.0 217028.0 217497.0 217796.0 218176.0 50345.2 50809.2 50833.7 50983.2 53593.5 1416.9 1446.9 1449.1 1456.8 1458.3 26493.3 26883.6 26890.9 27319.9 27628.6 37344.4 37650.4 37779.0 37814.2 37825.8 187158.0 187495.1 187529.0 188587.0 188850.1 33226.8 33956.2 34028.1 34211.5 34263.0 40644.0 41459.0 41463.0 41535.2 41614.6 30602.2 30927.2 31282.5 31518.7 31928.5 30607.7 30946.0 31046.7 31178.0 31906.2 33429.0 34934.5 34942.0 34971.8 35114.3 30538.8 30813.8 30918.2 31276.2 31374.2 22481.0 22667.9 22694.5 23009.0 23135.8 14:41:06 INFO - PID 4634 | 14:41:06 INFO - PID 4634 | [#2] jquery.html Cycles:180 Average:36351.97 Median:2171.30 stddev:85771.27 (3950.2%) stddev-sans-first:85969.82 14:41:06 INFO - PID 4634 | Values: 572.4 591.1 598.7 601.7 603.2 21939.1 22771.8 22773.3 22799.2 22840.9 20079.5 20315.3 21957.8 24630.4 24778.0 6364.7 6530.8 6536.8 6544.8 6546.0 6411.3 6529.7 6535.3 6837.8 7124.2 7064.3 7130.0 7130.8 7133.6 7152.6 6828.4 7087.4 7104.6 7132.3 7160.5 7019.5 7051.2 7056.2 7058.9 7081.5 30207.8 30982.5 31080.0 31131.0 31137.7 2144.8 2158.5 2170.4 2170.9 2171.7 19457.8 19478.2 19838.3 19959.5 19991.4 2507.9 2541.9 2598.3 2614.4 2617.8 128415.0 133430.0 137105.3 146099.0 146675.3 19320.4 19698.3 20402.4 21501.6 21578.7 42028.8 42463.0 42548.6 42623.1 42738.6 10732.9 10822.7 10887.2 10930.7 10941.7 8757.4 8855.9 8892.1 8918.9 8950.8 10766.0 11023.2 11316.6 11409.3 11539.9 3624.5 3842.1 3854.0 4305.8 4498.2 961.2 977.8 983.7 993.6 994.3 18555.4 18747.3 19024.9 19242.7 19514.1 1040.0 1043.3 1047.8 1051.7 1058.4 10428.3 10621.8 10648.9 10656.8 10709.7 504209.0 507005.0 509519.0 516565.0 520735.0 114546.0 114587.0 114629.4 116805.0 118019.0 1054.7 1091.6 1099.4 1144.4 1175.7 19495.2 19510.6 19834.0 19892.6 20371.6 56419.0 56533.7 56560.4 56564.2 58040.4 69163.3 69196.3 69269.0 69272.7 70876.6 18941.4 19602.4 19641.7 19735.1 19847.0 22120.0 22244.3 22381.9 22403.8 22593.3 17745.9 18065.8 18262.8 18264.6 18277.9 14470.8 15028.5 15060.3 15295.8 15866.8 18217.5 18232.8 18233.8 18571.4 18582.4 19147.1 19258.3 19260.7 19324.5 19459.6 17696.5 17704.0 17900.8 17918.6 18044.9 14:41:06 INFO - PID 4634 | 14:41:06 INFO - PID 4634 | [#3] mootools.html Cycles:180 Average:9517.77 Median:2772.18 stddev:6835.45 (246.6%) stddev-sans-first:6826.96 14:41:06 INFO - PID 4634 | Values: 1333.3 1397.0 1414.4 1425.5 1431.4 15788.2 16282.2 16334.4 16335.4 16346.3 15886.0 16085.8 16101.6 16101.8 16114.0 2771.2 2833.2 2833.7 2842.8 2857.8 2804.0 2809.4 2812.2 2829.7 2833.6 2745.8 2773.2 2853.1 2857.8 2858.2 2802.8 2833.7 2837.1 2838.3 2854.5 2650.2 2765.9 2778.8 2832.4 2836.5 15386.5 15427.8 15462.9 15506.1 15528.1 7858.1 8095.8 8153.6 8158.1 8163.1 5359.8 5400.0 5565.4 5566.9 5591.9 2016.1 2022.5 2039.2 2090.0 2095.1 26168.1 26362.9 26619.6 26627.6 26651.5 6729.9 6843.2 6926.5 7145.8 7175.6 17504.4 17628.0 17644.6 17663.1 17670.8 8034.3 8107.9 8200.5 8217.0 8225.1 7379.9 7412.6 7554.8 7556.5 7577.7 5254.3 5381.6 5416.2 5444.0 5468.0 1609.3 1610.7 1611.2 1616.8 1635.6 890.6 901.1 903.5 918.2 918.5 7314.7 7540.3 7558.2 7573.9 7614.4 708.4 738.3 743.5 757.9 762.7 4633.7 4989.0 5132.2 5185.9 5350.3 21648.0 22574.3 22676.5 22773.2 22773.5 21067.9 22193.7 22262.7 22455.3 22495.6 11400.5 11590.2 11590.4 11608.9 11643.9 7740.0 7874.9 7955.8 7984.3 8094.0 18401.9 18775.3 18795.4 18826.5 18913.9 19591.1 19664.4 19724.2 19779.3 20297.0 11444.9 11563.9 11669.9 11670.1 11685.7 14068.9 14136.6 14190.9 14307.9 14322.4 11041.0 11047.8 11070.6 11229.3 11308.8 10578.6 11139.8 11181.8 11338.5 11465.1 9790.5 9957.1 9976.7 10026.6 10110.0 7385.7 7511.4 7520.5 7543.0 7570.7 7550.4 7567.9 7621.3 7673.0 7737.2 14:41:06 INFO - PID 4634 | 14:41:06 INFO - PID 4634 | [#4] prototype.html Cycles:180 Average:5731.10 Median:6326.84 stddev:1530.80 (24.2%) stddev-sans-first:1484.32 14:41:06 INFO - PID 4634 | Values: 521.4 523.8 546.2 546.3 547.3 6163.6 6261.8 6333.7 6392.0 6409.5 6233.4 6256.3 6313.5 6320.0 6367.9 5238.7 5271.8 5273.1 5300.3 5340.2 5226.9 5252.6 5257.2 5348.9 5356.3 5292.3 5348.2 5351.8 5369.2 5381.0 5282.3 5290.4 5297.4 5327.7 5353.5 4965.5 4988.8 5055.0 5055.8 5062.9 6385.4 6393.6 6401.2 6422.2 6429.0 6094.4 6110.3 6181.5 6201.7 6203.5 6690.5 6722.8 6745.0 6770.5 6774.3 5423.2 5424.4 5460.9 5472.8 5503.3 7022.1 7089.5 7105.3 7185.9 7211.6 5568.7 5579.4 5632.5 5634.8 5635.2 5693.9 5722.4 5757.8 5758.8 5764.6 6140.2 6168.4 6219.7 6225.8 6227.2 6505.5 6703.2 6794.0 6839.7 6903.0 1822.5 1882.0 1941.1 1961.0 1974.8 1441.1 1442.9 1459.6 1476.3 1488.0 5599.3 5713.7 5725.7 5803.4 5835.2 6720.0 6725.8 6744.5 6820.1 6855.8 5734.4 5769.8 5788.8 5796.2 5829.0 3540.7 3544.6 3591.0 3648.7 3661.7 6422.1 6482.7 6528.4 6575.3 6674.5 6810.7 6831.8 6951.9 6993.8 7032.6 6487.9 6582.9 6602.5 6612.6 6667.5 6736.7 6794.5 6804.7 6911.4 6933.5 6688.0 6723.0 6763.7 6837.8 6848.8 6537.4 6574.5 6621.7 6705.6 6717.4 5175.1 5193.2 5193.9 5217.9 5223.5 6588.7 6859.6 6898.2 6916.5 6985.2 6505.9 6682.7 6686.8 6700.6 6706.0 6684.7 6689.8 6697.2 6713.6 6726.0 6484.5 6563.5 6601.5 6625.3 6649.0 6711.7 6788.4 6794.0 6822.7 6839.5 6340.7 6358.7 6365.3 6441.0 6449.4 14:41:06 INFO - PID 4634 | 14:41:06 INFO - PID 4634 | [#5] yui.html Cycles:180 Average:24788.24 Median:19924.75 stddev:34815.18 (174.7%) stddev-sans-first:34866.54 14:41:06 INFO - PID 4634 | Values: 874.6 891.5 897.6 903.0 923.9 18142.7 19131.3 19173.6 19215.9 19221.1 17506.6 17555.3 17655.2 17673.1 17811.0 926.6 941.6 949.4 953.1 954.5 971.3 974.1 975.2 975.7 977.6 980.7 1017.3 1026.4 1027.7 1030.9 1013.2 1018.7 1018.8 1019.0 1022.4 722.4 737.1 738.9 739.3 741.7 17359.5 17592.1 17614.6 17651.6 17695.1 21621.7 21910.3 21951.8 22106.0 22301.2 16223.5 16318.8 16509.6 16514.7 16829.9 3642.7 3670.8 3678.5 3679.7 3682.0 108539.5 136152.0 141600.0 142140.0 149480.3 16887.4 17273.6 17370.3 17480.9 17485.2 32193.4 32521.7 32632.2 32682.0 32697.5 9118.9 9190.0 9316.2 9331.8 9339.8 4236.7 4304.2 4304.9 4307.6 4324.3 5366.5 5448.9 5484.1 5486.0 5491.4 1065.8 1069.2 1091.0 1091.8 1094.1 685.2 702.9 706.3 710.6 715.0 12204.8 12297.3 12620.7 12963.8 13096.1 675.3 675.4 677.8 689.4 689.9 5719.3 5766.3 5803.3 5818.2 5888.4 124417.0 125926.0 128718.0 128796.0 130264.0 88090.6 93577.0 104142.5 106343.0 115677.4 89632.6 93057.0 94283.5 94649.0 99067.0 11904.2 12179.8 12206.4 12238.9 12318.8 42377.0 44590.8 45075.5 45272.5 46078.5 57817.4 57906.0 57965.4 58587.7 60426.4 18896.0 19149.6 19255.4 19378.3 19416.1 21045.6 21298.4 21595.5 21650.7 21704.8 19452.6 19855.2 19871.1 19880.0 19969.5 18531.4 18992.3 19038.5 19148.2 19238.7 19114.2 19468.5 19526.0 19657.3 19863.0 13078.6 13206.1 13286.6 13512.3 13536.6 13861.7 13974.3 14155.2 14182.9 14216.0 14:41:06 INFO - PID 4634 | -------- Summary: end -------- 14:41:06 INFO - PID 4634 | 14:41:07 INFO - TEST-INFO | 4634: exit 0 14:41:07 INFO - TEST-OK | dromaeo_css | took 1110296ms 14:41:07 INFO - TEST-START | kraken 14:41:07 INFO - Initialising browser for kraken test... 14:41:07 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44478/getInfo.html -profile /tmp/tmpKQZXmk/profile 14:41:07 INFO - TEST-INFO | started process 5001 (/builds/slave/test/build/application/firefox/firefox http://localhost:44478/getInfo.html) 14:41:13 INFO - TEST-INFO | 5001: exit 0 14:41:13 INFO - Browser initialized. 14:41:13 INFO - Running cycle 1/1 for kraken test... 14:41:13 INFO - Using env: {'DISPLAY': ':0', 14:41:13 INFO - 'HOME': '/home/cltbld', 14:41:13 INFO - 'JSGC_DISABLE_POISONING': '1', 14:41:13 INFO - 'LANG': 'en_US.UTF-8', 14:41:13 INFO - 'LANGUAGE': 'en_US:en', 14:41:13 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 14:41:13 INFO - 'LOGNAME': 'cltbld', 14:41:13 INFO - 'MAIL': '/var/mail/cltbld', 14:41:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:41:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:41:13 INFO - 'MOZ_CRASHREPORTER': '1', 14:41:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:13 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 14:41:13 INFO - 'MOZ_NO_REMOTE': '1', 14:41:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:41:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:41:13 INFO - 'NO_EM_RESTART': '1', 14:41:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:41:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:13 INFO - 'PWD': '/builds/slave/test', 14:41:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:41:13 INFO - 'RUST_BACKTRACE': 'full', 14:41:13 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:41:13 INFO - 'SHELL': '/bin/bash', 14:41:13 INFO - 'SHLVL': '1', 14:41:13 INFO - 'STYLO_FORCE_DISABLED': '1', 14:41:13 INFO - 'TERM': 'linux', 14:41:13 INFO - 'TMOUT': '86400', 14:41:13 INFO - 'USER': 'cltbld', 14:41:13 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506459664.612733-1226596283', 14:41:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:13 INFO - '_': '/tools/buildbot/bin/python'} 14:41:13 INFO - TEST-INFO | started process 5237 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKQZXmk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:41:14 INFO - PID 5237 | 14:41:14 INFO - PID 5237 | (/builds/slave/test/build/application/firefox/firefox:5286): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:41:14 INFO - PID 5237 | 14:41:24 INFO - PID 5237 | RSS: Main: 151195648 14:41:24 INFO - PID 5237 | 14:41:27 INFO - PID 5237 | Cycle 1(1): loaded http://localhost:44478/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44478/tests/kraken/driver.html?testName=audio-beat-detection) 14:41:28 INFO - PID 5237 | RSS: Main: 157229056 14:41:28 INFO - PID 5237 | 14:41:30 INFO - PID 5237 | Cycle 1(1): loaded http://localhost:44478/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44478/tests/kraken/driver.html?testName=audio-dft) 14:41:31 INFO - PID 5237 | RSS: Main: 157655040 14:41:31 INFO - PID 5237 | 14:41:34 INFO - PID 5237 | Cycle 1(1): loaded http://localhost:44478/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44478/tests/kraken/driver.html?testName=audio-fft) 14:41:35 INFO - PID 5237 | RSS: Main: 154624000 14:41:35 INFO - PID 5237 | 14:41:37 INFO - PID 5237 | Cycle 1(1): loaded http://localhost:44478/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44478/tests/kraken/driver.html?testName=audio-oscillator) 14:41:37 INFO - PID 5237 | RSS: Main: 155320320 14:41:37 INFO - PID 5237 | 14:41:39 INFO - PID 5237 | Cycle 1(1): loaded http://localhost:44478/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44478/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:41:40 INFO - PID 5237 | RSS: Main: 155611136 14:41:40 INFO - PID 5237 | 14:41:43 INFO - PID 5237 | Cycle 1(1): loaded http://localhost:44478/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44478/tests/kraken/driver.html?testName=imaging-darkroom) 14:41:44 INFO - PID 5237 | RSS: Main: 157814784 14:41:44 INFO - PID 5237 | 14:41:47 INFO - PID 5237 | Cycle 1(1): loaded http://localhost:44478/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44478/tests/kraken/driver.html?testName=imaging-desaturate) 14:41:48 INFO - PID 5237 | RSS: Main: 157732864 14:41:48 INFO - PID 5237 | 14:41:51 INFO - PID 5237 | Cycle 1(1): loaded http://localhost:44478/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44478/tests/kraken/driver.html?testName=json-parse-financial) 14:41:52 INFO - PID 5237 | RSS: Main: 157532160 14:41:52 INFO - PID 5237 | 14:41:53 INFO - PID 5237 | Cycle 1(1): loaded http://localhost:44478/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44478/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:41:54 INFO - PID 5237 | RSS: Main: 157523968 14:41:54 INFO - PID 5237 | 14:41:55 INFO - PID 5237 | Cycle 1(1): loaded http://localhost:44478/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44478/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:41:56 INFO - PID 5237 | RSS: Main: 157966336 14:41:56 INFO - PID 5237 | 14:41:58 INFO - PID 5237 | Cycle 1(1): loaded http://localhost:44478/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44478/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:41:59 INFO - PID 5237 | RSS: Main: 154607616 14:41:59 INFO - PID 5237 | 14:42:01 INFO - PID 5237 | Cycle 1(1): loaded http://localhost:44478/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44478/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:42:02 INFO - PID 5237 | RSS: Main: 154828800 14:42:02 INFO - PID 5237 | 14:42:05 INFO - PID 5237 | Cycle 1(1): loaded http://localhost:44478/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44478/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:42:06 INFO - PID 5237 | RSS: Main: 155172864 14:42:06 INFO - PID 5237 | 14:42:07 INFO - PID 5237 | Cycle 1(1): loaded http://localhost:44478/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44478/tests/kraken/driver.html?testName=ai-astar) 14:42:08 INFO - PID 5237 | RSS: Main: 156160000 14:42:08 INFO - PID 5237 | 14:42:08 INFO - PID 5237 | __start_tp_report 14:42:08 INFO - PID 5237 | _x_x_mozilla_page_load 14:42:08 INFO - PID 5237 | _x_x_mozilla_page_load_details 14:42:08 INFO - PID 5237 | |i|pagename|runs| 14:42:08 INFO - PID 5237 | |0;ai-astar;109;110;108;108;107;109;111;107;108;110 14:42:08 INFO - PID 5237 | |1;audio-beat-detection;116;117;116;119;118;117;116;117;141;119 14:42:08 INFO - PID 5237 | |2;audio-dft;165;162;162;162;163;162;165;163;165;164 14:42:08 INFO - PID 5237 | |3;audio-fft;75;77;74;73;74;75;83;73;73;74 14:42:08 INFO - PID 5237 | |4;audio-oscillator;81;80;79;78;78;78;79;80;80;80 14:42:08 INFO - PID 5237 | |5;imaging-gaussian-blur;113;114;114;113;114;114;113;113;115;114 14:42:08 INFO - PID 5237 | |6;imaging-darkroom;148;148;148;148;148;150;148;148;150;148 14:42:08 INFO - PID 5237 | |7;imaging-desaturate;97;94;94;94;99;94;99;99;99;99 14:42:08 INFO - PID 5237 | |8;json-parse-financial;51;51;53;56;53;52;55;53;51;49 14:42:08 INFO - PID 5237 | |9;json-stringify-tinderbox;38;38;37;37;38;37;38;38;38;38 14:42:08 INFO - PID 5237 | |10;stanford-crypto-aes;76;77;73;74;73;73;75;72;74;73 14:42:08 INFO - PID 5237 | |11;stanford-crypto-ccm;118;110;110;116;115;111;110;113;123;122 14:42:08 INFO - PID 5237 | |12;stanford-crypto-pbkdf2;165;167;178;166;169;169;168;166;169;169 14:42:08 INFO - PID 5237 | |13;stanford-crypto-sha256-iterative;65;73;68;63;63;66;67;69;70;65 14:42:08 INFO - PID 5237 | __end_tp_report 14:42:08 INFO - PID 5237 | __start_cc_report 14:42:08 INFO - PID 5237 | _x_x_mozilla_cycle_collect,772 14:42:08 INFO - PID 5237 | __end_cc_report 14:42:08 INFO - PID 5237 | __startTimestamp1506462128044__endTimestamp 14:42:08 INFO - PID 5237 | 14:42:08 INFO - PID 5237 | ------- Summary: start ------- 14:42:08 INFO - PID 5237 | Number of tests: 14 14:42:08 INFO - PID 5237 | 14:42:08 INFO - PID 5237 | [#0] ai-astar Cycles:10 Average:108.70 Median:109.00 stddev:1.34 (1.2%) stddev-sans-first:1.41 14:42:08 INFO - PID 5237 | Values: 109.0 110.0 108.0 108.0 107.0 109.0 111.0 107.0 108.0 110.0 14:42:08 INFO - PID 5237 | 14:42:08 INFO - PID 5237 | [#1] audio-beat-detection Cycles:10 Average:119.60 Median:117.50 stddev:7.60 (6.5%) stddev-sans-first:7.95 14:42:08 INFO - PID 5237 | Values: 116.0 117.0 116.0 119.0 118.0 117.0 116.0 117.0 141.0 119.0 14:42:08 INFO - PID 5237 | 14:42:08 INFO - PID 5237 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.50 stddev:1.34 (0.8%) stddev-sans-first:1.27 14:42:08 INFO - PID 5237 | Values: 165.0 162.0 162.0 162.0 163.0 162.0 165.0 163.0 165.0 164.0 14:42:08 INFO - PID 5237 | 14:42:08 INFO - PID 5237 | [#3] audio-fft Cycles:10 Average:75.10 Median:74.50 stddev:3.03 (4.1%) stddev-sans-first:3.22 14:42:08 INFO - PID 5237 | Values: 75.0 77.0 74.0 73.0 74.0 75.0 83.0 73.0 73.0 74.0 14:42:08 INFO - PID 5237 | 14:42:08 INFO - PID 5237 | [#4] audio-oscillator Cycles:10 Average:79.30 Median:80.00 stddev:1.06 (1.3%) stddev-sans-first:0.93 14:42:08 INFO - PID 5237 | Values: 81.0 80.0 79.0 78.0 78.0 78.0 79.0 80.0 80.0 80.0 14:42:08 INFO - PID 5237 | 14:42:08 INFO - PID 5237 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 14:42:08 INFO - PID 5237 | Values: 113.0 114.0 114.0 113.0 114.0 114.0 113.0 113.0 115.0 114.0 14:42:08 INFO - PID 5237 | 14:42:08 INFO - PID 5237 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.00 stddev:0.84 (0.6%) stddev-sans-first:0.88 14:42:08 INFO - PID 5237 | Values: 148.0 148.0 148.0 148.0 148.0 150.0 148.0 148.0 150.0 148.0 14:42:08 INFO - PID 5237 | 14:42:08 INFO - PID 5237 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:99.00 stddev:2.49 (2.5%) stddev-sans-first:2.64 14:42:08 INFO - PID 5237 | Values: 97.0 94.0 94.0 94.0 99.0 94.0 99.0 99.0 99.0 99.0 14:42:08 INFO - PID 5237 | 14:42:08 INFO - PID 5237 | [#8] json-parse-financial Cycles:10 Average:52.40 Median:53.00 stddev:2.07 (3.9%) stddev-sans-first:2.13 14:42:08 INFO - PID 5237 | Values: 51.0 51.0 53.0 56.0 53.0 52.0 55.0 53.0 51.0 49.0 14:42:08 INFO - PID 5237 | 14:42:08 INFO - PID 5237 | [#9] json-stringify-tinderbox Cycles:10 Average:37.70 Median:38.00 stddev:0.48 (1.3%) stddev-sans-first:0.50 14:42:08 INFO - PID 5237 | Values: 38.0 38.0 37.0 37.0 38.0 37.0 38.0 38.0 38.0 38.0 14:42:08 INFO - PID 5237 | 14:42:08 INFO - PID 5237 | [#10] stanford-crypto-aes Cycles:10 Average:74.00 Median:74.00 stddev:1.56 (2.1%) stddev-sans-first:1.48 14:42:08 INFO - PID 5237 | Values: 76.0 77.0 73.0 74.0 73.0 73.0 75.0 72.0 74.0 73.0 14:42:08 INFO - PID 5237 | 14:42:08 INFO - PID 5237 | [#11] stanford-crypto-ccm Cycles:10 Average:114.80 Median:115.50 stddev:4.92 (4.3%) stddev-sans-first:5.08 14:42:08 INFO - PID 5237 | Values: 118.0 110.0 110.0 116.0 115.0 111.0 110.0 113.0 123.0 122.0 14:42:08 INFO - PID 5237 | 14:42:08 INFO - PID 5237 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.60 Median:169.00 stddev:3.63 (2.1%) stddev-sans-first:3.61 14:42:08 INFO - PID 5237 | Values: 165.0 167.0 178.0 166.0 169.0 169.0 168.0 166.0 169.0 169.0 14:42:08 INFO - PID 5237 | 14:42:08 INFO - PID 5237 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.50 stddev:3.18 (4.7%) stddev-sans-first:3.30 14:42:08 INFO - PID 5237 | Values: 65.0 73.0 68.0 63.0 63.0 66.0 67.0 69.0 70.0 65.0 14:42:08 INFO - PID 5237 | -------- Summary: end -------- 14:42:08 INFO - PID 5237 | 14:42:08 INFO - PID 5237 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 14:42:08 INFO - TEST-INFO | 5237: exit 0 14:42:08 INFO - TEST-OK | kraken | took 61223ms 14:42:08 INFO - SUITE-END | took 1171s 14:42:09 INFO - Completed test suite (00:19:31) 14:42:09 INFO - javascript benchmark 14:42:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8730.014109620479, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3139.874405023799, 3157.6210854697424, 3170.968290317096, 3187.7927934684258, 3193.0580478758766, 6161.476274516672, 6215.067739839015, 6243.594166379188, 6333.873322533553, 6350.555461117718, 6231.844203894893, 6248.84377890553, 6267.37326267373, 6290.308066112735, 6331.4618257448055, 5827.533797296227, 5868.2664666916635, 5870.442307980735, 5919.0, 5945.346011938684, 1253.3469307568864, 5718.59969802114, 5832.854178645525, 5852.573406552847, 5932.7330270137945, 5359.0, 5699.0, 5814.505767009767, 5815.941840581582, 5843.64938103713, 5786.5370770338695, 5796.82609521715, 5890.646561206298, 5893.616914900561, 5895.292564892197, 5745.2818397700285, 5756.222909907151, 5817.127430885359, 5833.912491312633, 5834.737436815353, 6203.96898015507, 6263.31103578606, 6317.1156038154695, 6346.682665866734, 6419.679016049179, 6547.9345206547805, 6701.1623547056615, 6717.294684058153, 6768.255491895888, 6868.828279293008, 6826.863462730717, 6831.760888368884, 6838.316168383171, 6844.828879278008, 6925.168979722465, 6266.5926714763855, 6282.78010269643, 6364.013577895434, 6364.236291644986, 6405.167328247298, 7007.054047703597, 7011.404030657452, 7016.052832867497, 7077.256888026786, 7098.538594991309, 6458.773942912069, 6591.604503729792, 6596.934030659728, 6603.834904127435, 6604.3725846044545, 6694.9665251674405, 6716.0, 6794.864102717918, 6811.863762724718, 6815.045893574904, 6667.599944003376, 6815.965920170367, 6831.69257383409, 6833.180018397725, 6837.418819400307, 6790.11728475305, 6791.456683465311, 6872.037914691947, 6878.828029299308, 6892.483063770237, 5187.4553171916405, 5291.894162116813, 5336.306280183629, 5406.513413792777, 5409.350877894599, 4571.405717256802, 4662.230731929194, 4705.7411842349, 4719.693219940693, 4721.15019296523, 5791.102379131242, 5839.357670656224, 5867.61860479076, 5871.060630299132, 5879.382664820132, 6720.2943690912725, 6754.5947243165565, 6844.5208835382045, 6856.451483881277, 6867.313268673192, 5683.318001839806, 5710.0, 5787.421257874179, 5789.710514474259, 5850.824475265749, 5844.707764611752, 5848.766049357978, 5859.2382990211, 5889.823305300848, 5891.381404952418, 6474.255460621995, 6479.125318082093, 6555.246146693096, 6564.015397690289, 6648.567843090281, 6562.606243625398, 6696.19645642526, 6810.795676129724, 6903.861922761617, 6910.585364878123, 6449.6130232186215, 6491.902621460777, 6493.415592596689, 6501.772437964649, 6516.674166291572, 6618.6690665467495, 6709.161354830646, 6741.797746067626, 6746.089277947414, 6764.188297404343, 6710.865782684416, 6822.488313376616, 6866.0, 6871.587704737732, 6875.968604709334, 6380.0, 6497.0, 6539.6403197824575, 6553.606783593, 6643.900341494785, 6454.870902581828, 6464.030395440722, 6489.772857949949, 6495.9025614614875, 6561.1470508835455, 6469.708863101077, 6519.576227545194, 6537.477001839937, 6558.57369271015, 6593.208814942238, 6515.250746164252, 6639.634820084942, 6701.430378417694, 6725.19297684281, 6737.797866064026, 6278.780242691484, 6373.362663733589, 6412.0, 6485.027245912962, 6488.870222595616], "value": 6132.205363219164, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [853.4623187391946, 887.2325438495701, 889.3680097021972, 908.1372695938855, 911.8176364727054, 40601.0, 41287.0, 41368.37947430791, 41438.0, 41492.792536037276, 36368.09079773007, 36538.451923221175, 36878.44682329761, 36925.630743692556, 36980.81509592448, 7054.894176587355, 7221.350078492935, 7244.71021159153, 7246.311600397954, 7246.528975616595, 7173.10336207974, 7208.9639551802165, 7214.062171917643, 7248.637568121573, 7257.346838784509, 7618.923810761905, 7863.13505514393, 7871.448998570074, 7873.330766884822, 7874.97625308709, 7754.728584499544, 7778.727744528971, 7780.533168009909, 7782.688692452295, 7815.0, 7622.123455802598, 7767.417443691746, 7842.254985776342, 7856.607169641495, 7867.252611001945, 37673.81163094194, 37754.62245377539, 38071.0, 38093.23813523714, 38128.0, 3525.048236976028, 3577.83899724513, 3579.284143171376, 3585.1933315004176, 3585.265020670782, 30953.690463095307, 30986.0, 31160.844195779104, 31173.532397014063, 31185.22036949072, 5066.949330506684, 5101.897962040775, 5110.66780659256, 5154.252633368178, 5156.278121063054, 185214.0, 187636.0, 188244.99999999863, 188507.0, 188688.05655971632, 47843.76078119587, 48118.0, 48140.518594813606, 48300.5169948296, 48457.515424846, 50243.24635130476, 50256.24615630769, 50256.24615630769, 50416.747916260916, 50503.747481262355, 16263.18684065792, 16567.840251182544, 16569.502914912573, 16581.25384357707, 16588.08765517884, 13595.864041359657, 13600.863991360158, 13609.11540749848, 13632.522861699794, 13650.931745341408, 13904.51334203298, 14145.363458644386, 14226.0, 14231.928840355939, 14369.856301437061, 5660.264165658438, 5739.85650358736, 5798.680527788918, 5808.514891065412, 5822.854428639318, 997.0976266478848, 998.9850152247722, 1022.1260821997085, 1028.9897101029044, 1036.160709825029, 22625.54748905013, 22672.886635566716, 23078.192263270706, 23120.4219894504, 23150.1897433589, 1075.5106426576046, 1080.0, 1099.9725006874892, 1112.5883423133491, 1113.3097479562562, 12064.819027714591, 12115.454804533818, 12141.635750927486, 12143.514259429701, 12170.81743773844, 214809.0, 217028.0, 217497.0, 217796.0, 218176.0, 50345.24482132771, 50809.237861432106, 50833.74583127061, 50983.235251471255, 53593.46406535885, 1416.9149851008767, 1446.8770154536983, 1449.0943160524673, 1456.8033315502485, 1458.2562892924684, 26493.33766655849, 26883.596746049217, 26890.86554567293, 27319.86340068287, 27628.585571216045, 37344.43983340198, 37650.43524347192, 37779.0, 37814.2437151261, 37825.81087094547, 187158.0, 187495.0625246865, 187529.0, 188587.0, 188850.05574972037, 33226.83386583148, 33956.15109622279, 34028.149296267795, 34211.4868276981, 34263.0, 40644.0, 41459.0, 41463.0, 41535.169296614506, 41614.58385416107, 30602.234944125685, 30927.226819329695, 31282.497400208384, 31518.684813151576, 31928.52107218347, 30607.693923061375, 30946.0, 31046.689533105284, 31178.0, 31906.20234494156, 33429.0, 34934.47598285977, 34942.0, 34971.825140874134, 35114.297714046086, 30538.84730576422, 30813.845930770203, 30918.227044323172, 31276.218094547818, 31374.215644609067, 22481.0, 22667.88666056659, 22694.546109078055, 23009.0, 23135.768642314033], "value": 16986.846338214727, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.4189947203589, 591.0985746736229, 598.6677394046305, 601.7292218501675, 603.1766638538395, 21939.122435102596, 22771.772282277172, 22773.31680049601, 22799.202027929026, 22840.88579557102, 20079.498012549695, 20315.288964886196, 21957.780422195774, 24630.384240394, 24778.0, 6364.713587888545, 6530.8040758777315, 6536.836579085513, 6544.770933017346, 6546.0, 6411.326810684881, 6529.738810447577, 6535.281119076922, 6837.829054273658, 7124.216336203013, 7064.25825288345, 7129.964350178242, 7130.786076417689, 7133.57198568085, 7152.606606636633, 6828.351306625863, 7087.362137407632, 7104.573725576456, 7132.2867713228525, 7160.462965277573, 7019.473539484508, 7051.224365319811, 7056.15326160864, 7058.858822823566, 7081.468889833283, 30207.848960755276, 30982.535261970865, 31080.0, 31131.0, 31137.688623113707, 2144.8176904963098, 2158.5467051919118, 2170.435686721448, 2170.913163473459, 2171.685105659686, 19457.805421945883, 19478.220871165136, 19838.305659302, 19959.50101247466, 19991.40025799228, 2507.9373015674573, 2541.9237422877345, 2598.2724837045657, 2614.3856193794445, 2617.764401203901, 128415.0, 133430.0, 137105.31447342798, 146099.0, 146675.26662366727, 19320.42038738812, 19698.340724002363, 20402.38792836217, 21501.56996860054, 21578.676319855214, 42028.78985605114, 42463.0, 42548.57451425508, 42623.14753704909, 42738.57261427408, 10732.946335268274, 10822.673125278103, 10887.237893347548, 10930.726731831608, 10941.671749847517, 8757.386982911263, 8855.867161992446, 8892.110788921056, 8918.910810891808, 8950.776230594287, 10766.0, 11023.17326200538, 11316.6039188628, 11409.315441073562, 11539.884601154048, 3624.5469316335457, 3842.135519508144, 3853.96146038536, 4305.763183024964, 4498.190325741398, 961.2118063188259, 977.7702239973601, 983.7294743945472, 993.6025589764008, 994.3487016004528, 18555.35056273024, 18747.34384296543, 19024.90487547581, 19242.71135932962, 19514.12186451613, 1040.0431602925328, 1043.2905624175633, 1047.779966207105, 1051.6792378324685, 1058.402002868377, 10428.270021098602, 10621.787564248672, 10648.893511064945, 10656.840147397796, 10709.678709638723, 504209.0, 507005.0, 509519.0, 516565.0, 520735.0, 114546.0, 114587.0, 114629.4268528652, 116805.0, 118019.0, 1054.6888667843004, 1091.645215305029, 1099.378850949211, 1144.376314908377, 1175.735459521618, 19495.220191192195, 19510.60978780445, 19834.0, 19892.60214795725, 20371.59256814885, 56419.0, 56533.71733141308, 56560.43439565552, 56564.15153772779, 58040.4195958035, 69163.30836691569, 69196.30803691898, 69269.0, 69272.6536367315, 70876.64561677158, 18941.43175704731, 19602.411927642195, 19641.705374419682, 19735.11191996335, 19847.0, 22120.0, 22244.332670019925, 22381.88809055944, 22403.77596224082, 22593.322200334016, 17745.911270443565, 18065.819341806415, 18262.817371826644, 18264.634707305515, 18277.908610456863, 14470.782938255725, 15028.549143525712, 15060.322285496959, 15295.77056344178, 15866.841331586536, 18217.45347639573, 18232.81767182311, 18233.81766182374, 18571.350002749838, 18582.44252672422, 19147.13837877271, 19258.325958591384, 19260.711089333952, 19324.516887077374, 19459.610807784047, 17696.469105926844, 17704.0, 17900.820991789915, 17918.5520361992, 18044.90977545104], "value": 12775.316923862381, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1333.3133436280314, 1396.9511067112646, 1414.3564678071477, 1425.5367005723135, 1431.3916585451186, 15788.210589470524, 16282.185890705461, 16334.428295009677, 16335.428260010902, 16346.34614615414, 15886.046837189777, 16085.758713619305, 16101.597460063504, 16101.83898161018, 16114.0, 2771.196353057611, 2833.2067021234034, 2833.744962953334, 2842.7725781937497, 2857.7999540032206, 2804.0, 2809.35384861482, 2812.2406950123454, 2829.7170282971742, 2833.5607980763016, 2745.7803375729895, 2773.1680495851165, 2853.058490698065, 2857.785666075042, 2858.2425657200856, 2802.8038037337396, 2833.659960804696, 2837.1488553433887, 2838.3188034871587, 2854.5147324954805, 2650.2314328844614, 2765.9308517287227, 2778.763805076571, 2832.433513297349, 2836.4752520783513, 15386.538403847902, 15427.845721542753, 15462.922685386613, 15506.069635821887, 15528.145951972638, 7858.09631892334, 8095.838083238361, 8153.633086511121, 8158.143394943564, 8163.061247956502, 5359.791833856173, 5400.0, 5565.443455654443, 5566.944330556683, 5591.916121258185, 2016.0927582587894, 2022.5247066939257, 2039.2149022626247, 2089.958200835975, 2095.078165607143, 26168.084117056, 26362.94548218069, 26619.600705989425, 26627.600585991226, 26651.46697066048, 6729.899051514231, 6843.178818541707, 6926.515143939977, 7145.821354466076, 7175.605341706152, 17504.38734644307, 17628.030458324916, 17644.558886027953, 17663.11684415774, 17670.823291767174, 8034.317083047889, 8107.878381824277, 8200.548969806718, 8216.958915205505, 8225.054118776417, 7379.926200738031, 7412.592307423143, 7554.773356799305, 7556.546607203585, 7577.659005344773, 5254.343207099113, 5381.596380271495, 5416.160495123262, 5443.972780136074, 5467.972660136674, 1609.2999545197877, 1610.6617610301732, 1611.1541440743704, 1616.8383161683973, 1635.623806524506, 890.5547226386807, 901.0898992017978, 903.4895284164426, 918.1736437206567, 918.490237917962, 7314.743983960642, 7540.3213710766295, 7558.168601453835, 7573.886391704129, 7614.428917831185, 708.3943228539524, 738.3059923671732, 743.5427212264526, 757.8560073586001, 762.7063580521428, 4633.745144017044, 4988.9750551247735, 5132.153194722903, 5185.896282074337, 5350.3312085989255, 21648.0, 22574.322770316918, 22676.546469070527, 22773.202937897095, 22773.544529109324, 21067.8946605266, 22193.667094993587, 22262.666060009113, 22455.32634020982, 22495.550088998127, 11400.543978240943, 11590.188686791844, 11590.420478976017, 11608.941955290169, 11643.941780290876, 7740.0, 7874.921250787419, 7955.801104972422, 7984.321332686786, 8093.959530202312, 18401.90799045996, 18775.34286299973, 18795.436136915916, 18826.52933676669, 18913.905430472758, 19591.118399671763, 19664.41006769799, 19724.211031558578, 19779.307724229584, 20297.0, 11444.885551144715, 11563.88436115628, 11669.88330116688, 11670.124740644316, 11685.707857303636, 14068.859311406755, 14136.575902722934, 14190.858091418953, 14307.856921431068, 14322.427102916183, 11041.0, 11047.83428248593, 11070.557177713123, 11229.27009744364, 11308.830367544659, 10578.629747958785, 11139.777204456028, 11181.832272515756, 11338.546458141582, 11465.082793376343, 9790.46152461593, 9957.103860652576, 9976.650817221362, 10026.598936042477, 10110.039546243095, 7385.667644955883, 7511.436642251962, 7520.511166774361, 7542.962285188539, 7570.659320330488, 7550.395968322411, 7567.9243207569425, 7621.31408173267, 7673.0, 7737.187595302637], "value": 6770.413223744156, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [521.4212224430881, 523.8009556368577, 546.2461802712257, 546.2707285773497, 547.31312203185, 6163.59936604121, 6261.780837670683, 6333.651649159295, 6391.968040159799, 6409.455196308313, 6233.40782625651, 6256.311805701369, 6313.453203965035, 6320.027573942626, 6367.904481432783, 5238.659487133344, 5271.808911915017, 5273.129933560977, 5300.284461597693, 5340.1576456122575, 5226.876221612352, 5252.579793616521, 5257.158854583267, 5348.893022139555, 5356.303680521527, 5292.338457692788, 5348.171033489796, 5351.839444816662, 5369.221462887879, 5381.0, 5282.339707536558, 5290.39160496544, 5297.443768404339, 5327.733613319358, 5353.464653534655, 4965.478624744422, 4988.775505102279, 5054.974725126388, 5055.848324550233, 5062.949370506285, 6385.393387628214, 6393.6163830170335, 6401.199850018747, 6422.197225346832, 6429.0, 6094.421030002142, 6110.327863934964, 6181.536384771161, 6201.6899155042065, 6203.472704820096, 6690.498212634072, 6722.83192920176, 6744.966275168642, 6770.458363330922, 6774.254831968528, 5423.234150583192, 5424.430434804328, 5460.890782184334, 5472.753726082336, 5503.284573005523, 7022.068931044004, 7089.539179953338, 7105.253948335402, 7185.856282874365, 7211.639418029077, 5568.721563921868, 5579.38626751057, 5632.549396048306, 5634.774609015675, 5635.154726790932, 5693.857653558694, 5722.37053924068, 5757.798477053283, 5758.798442054592, 5764.596478246483, 6140.2017737694705, 6168.35232300602, 6219.7249563839305, 6225.844353891099, 6227.20140714164, 6505.512086593524, 6703.229128650268, 6794.0, 6839.658017099126, 6902.965485172542, 1822.4532640207885, 1881.9623607528047, 1941.0977242302622, 1960.9509762256057, 1974.7729011163613, 1441.0921119694526, 1442.9422823087168, 1459.6496840758355, 1476.2618690654672, 1487.970240595182, 5599.328080630269, 5713.74288157034, 5725.713714314267, 5803.448672376117, 5835.2122463466885, 6719.966400168066, 6725.798226053226, 6744.527883048139, 6820.147481564804, 6855.760048398282, 5734.426557344315, 5769.798057067983, 5788.787223091141, 5796.188533605298, 5829.0, 3540.73444491659, 3544.5923718772156, 3590.9640903591153, 3648.7445878788762, 3661.6521430464063, 6422.100905873182, 6482.661429363881, 6528.412442880163, 6575.309592492719, 6674.466042716571, 6810.693518791666, 6831.795046148623, 6951.930480695129, 6993.825154371079, 7032.648367581601, 6487.902681459782, 6582.873135260713, 6602.504812139109, 6612.6032438054835, 6667.499937504804, 6736.696848641921, 6794.524383293122, 6804.727810887509, 6911.373678002327, 6933.5493192942295, 6688.0, 6722.9663851680425, 6763.6618169092335, 6837.829054273683, 6848.794536163923, 6537.378948999837, 6574.474042076718, 6621.656063687999, 6705.597664140168, 6717.429018533479, 5175.120229561059, 5193.221016847503, 5193.896122077462, 5217.869553261199, 5223.503767142115, 6588.670566471753, 6859.622720750406, 6898.172219333512, 6916.481263905328, 6985.1967023790885, 6505.902411463737, 6682.665866706548, 6686.796376652249, 6700.626371593909, 6705.966470167618, 6684.665766711742, 6689.76585819494, 6697.162854643169, 6713.597184168965, 6725.9663701681175, 6484.5460817742305, 6563.540552161494, 6601.504887133388, 6625.271220165874, 6648.966755166193, 6711.738046340706, 6788.355106264897, 6793.966030169818, 6822.692978816064, 6839.487038472234, 6340.700156468005, 6358.682065896594, 6365.331640177715, 6440.967795160994, 6449.3873082057125], "value": 5291.37753502659, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [874.5670892908007, 891.5007595746387, 897.6454300551283, 902.9548522573874, 923.9399439036464, 18142.727859082108, 19131.330403435866, 19173.616527669437, 19215.903920480396, 19221.1350489228, 17506.649867002652, 17555.297788088494, 17655.20551575179, 17673.116344182803, 17811.0, 926.6061923682441, 941.5668792355491, 949.3876449689946, 953.1469334945219, 954.4798085043633, 971.3200759468365, 974.0892265731528, 975.2149519636689, 975.7267964969819, 977.5991843344231, 980.6763767956558, 1017.3285631483222, 1026.4457193115709, 1027.6968294353185, 1030.9072183503483, 1013.2350075692879, 1018.6536577563589, 1018.816613009658, 1019.0115587879782, 1022.4223313827664, 722.443718336883, 737.0602481835649, 738.8780851159552, 739.3087463221905, 741.6551303643831, 17359.479215623553, 17592.12039398025, 17614.559636009075, 17651.55871103233, 17695.115244237735, 21621.67567486489, 21910.342689719175, 21951.780482195292, 22106.0, 22301.21945731908, 16223.51329460118, 16318.836811631969, 16509.58726031859, 16514.6697066058, 16829.91585042079, 3642.690371318441, 3670.834812433447, 3678.5401824771902, 3679.6504332088675, 3681.9631803681887, 108539.45730271377, 136152.0, 141600.0, 142140.0, 149480.25259873632, 16887.408940687015, 17273.56816079583, 17370.3051877926, 17480.91259543694, 17485.213165407586, 32193.35613287768, 32521.674783251863, 32632.184195395304, 32682.0, 32697.50953735696, 9118.908810911938, 9189.954050229706, 9316.208122309545, 9331.766705832273, 9339.766505837273, 4236.724612900151, 4304.16068866568, 4304.892377690583, 4307.612314891675, 4324.286492728665, 5366.517013468807, 5448.863778405572, 5484.067708489566, 5486.0, 5491.395946445888, 1065.8454524094118, 1069.235496619905, 1091.045335331585, 1091.7598128411737, 1094.124700239805, 685.2188505104185, 702.880510313248, 706.2549010793662, 710.6304721544768, 715.0204220218334, 12204.816927746091, 12297.262164270172, 12620.684482888002, 12963.805542916863, 13096.148750331198, 675.3280485916447, 675.4258879952001, 677.806825054857, 689.4449967775888, 689.899964505144, 5719.3422756382715, 5766.279215098113, 5803.332616749043, 5818.214541036906, 5888.440598143169, 124417.0, 125926.0, 128718.0, 128796.0, 130264.0, 88090.55954720185, 93577.0, 104142.47928760308, 106343.0, 115677.42161289309, 89632.5518372417, 93057.0, 94283.52858235665, 94649.0, 99067.0, 11904.166708330335, 12179.75640487203, 12206.389680516117, 12238.877611223774, 12318.75362492763, 42377.0, 44590.77704611456, 45075.549244507136, 45272.547274526834, 46078.53921460742, 57817.4218257812, 57906.0, 57965.420345796, 58587.70706146442, 60426.395736043836, 18896.0, 19149.617007660047, 19255.422337329903, 19378.321758738377, 19416.126274317972, 21045.579088418453, 21298.36104916855, 21595.460113497287, 21650.67523987173, 21704.782952170277, 19452.610947780682, 19855.205791768745, 19871.105800238736, 19880.0, 19969.500762481053, 18531.44405667832, 18992.335268265546, 19038.524036899187, 19148.234070637576, 19238.71141932844, 19114.23543058262, 19468.513287167934, 19526.0, 19657.311994080137, 19863.0, 13078.607641770763, 13206.141600795918, 13286.601401957956, 13512.256825874278, 13536.59390218295, 13861.653458663613, 13974.30128493551, 14155.221462819232, 14182.92908535492, 14216.0], "value": 9284.953376404068, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1419.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 108.0, 108.0, 107.0, 109.0, 111.0, 107.0, 108.0, 110.0], "value": 108.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 119.0, 118.0, 117.0, 116.0, 117.0, 141.0, 119.0], "value": 119.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 162.0, 162.0, 163.0, 162.0, 165.0, 163.0, 165.0, 164.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 74.0, 73.0, 74.0, 75.0, 83.0, 73.0, 73.0, 74.0], "value": 75.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 79.0, 78.0, 78.0, 78.0, 79.0, 80.0, 80.0, 80.0], "value": 79.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 113.0, 114.0, 114.0, 113.0, 113.0, 115.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 148.0, 150.0, 148.0, 148.0, 150.0, 148.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 94.0, 94.0, 94.0, 99.0, 94.0, 99.0, 99.0, 99.0, 99.0], "value": 96.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 53.0, 56.0, 53.0, 52.0, 55.0, 53.0, 51.0, 49.0], "value": 52.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 37.0, 37.0, 38.0, 37.0, 38.0, 38.0, 38.0, 38.0], "value": 37.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 73.0, 74.0, 73.0, 73.0, 75.0, 72.0, 74.0, 73.0], "value": 74.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 110.0, 110.0, 116.0, 115.0, 111.0, 110.0, 113.0, 123.0, 122.0], "value": 114.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 167.0, 178.0, 166.0, 169.0, 169.0, 168.0, 166.0, 169.0, 169.0], "value": 168.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 73.0, 68.0, 63.0, 63.0, 66.0, 67.0, 69.0, 70.0, 65.0], "value": 66.9, "unit": "score"}]}]} 14:42:09 INFO - Return code: 0 14:42:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:42:09 INFO - # TBPL SUCCESS # 14:42:09 INFO - Running post-action listener: _package_coverage_data 14:42:09 INFO - Running post-action listener: _resource_record_post_action 14:42:09 INFO - [mozharness: 2017-09-26 21:42:09.317778Z] Finished run-tests step (success) 14:42:09 INFO - Running post-run listener: _resource_record_post_run 14:42:09 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 335220736; Read time: 12; Write time: 449420 14:42:09 INFO - TinderboxPrint: CPU usage
13.1% 14:42:09 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 14:42:09 INFO - TinderboxPrint: I/O write bytes / time
335,220,736 / 449,420 14:42:09 INFO - TinderboxPrint: CPU idle
8,240.0 (86.8%) 14:42:09 INFO - TinderboxPrint: CPU user
1,194.4 (12.6%) 14:42:09 INFO - TinderboxPrint: Swap in / out
0 / 0 14:42:09 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 9859072; Read time: 0; Write time: 1904 14:42:09 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 14:42:09 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 324608000; Read time: 0; Write time: 447460 14:42:09 INFO - Running post-run listener: _upload_blobber_files 14:42:09 INFO - Blob upload gear active. 14:42:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:42:09 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 14:42:09 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'] 14:42:09 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 14:42:10 INFO - (blobuploader) - INFO - Open directory for files ... 14:42:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 14:42:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:42:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:42:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 14:42:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:42:11 INFO - (blobuploader) - INFO - Done attempting. 14:42:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 14:42:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:42:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:42:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 14:42:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:42:12 INFO - (blobuploader) - INFO - Done attempting. 14:42:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:42:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:42:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:42:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:42:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:42:16 INFO - (blobuploader) - INFO - Done attempting. 14:42:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:42:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:42:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:42:17 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:42:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:42:17 INFO - (blobuploader) - INFO - Done attempting. 14:42:17 INFO - (blobuploader) - INFO - Iteration through files over. 14:42:17 INFO - Return code: 0 14:42:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:42:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:42:17 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/733a5b48ea9b36caa5f300c9b82ed2eaa0a65da289ab238edea3a74897c50b5fc0433d8b82c6c7ba34bef676ad173c52fa3932ae916fea08a7a5f116e4a0b798", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f96f05a611cd1abbccff3f26d6b3a62e1a16bc295397c12e5129a333d2375e0ea3d6254f3e8dca0c9c0827cfe7d27b715b11502ebbe37ae18251de3a48575078", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5525edb553f2de59f2a5318242d5631df8fa07db44bdf3a5fdb8fa0c2998231dbdfb59925536abd841d74e55a85f6ab15831dd855103766a8c48c2b3e0642c13", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/050aa79ab723ab7a756099dcadaf76a4918c830b3dce50deabfa523a9f267af53f163b77ca0ca00bee50a132248a6a749268eceef56f3975efccb6ea990b81a1"} 14:42:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:42:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:42:17 INFO - Contents: 14:42:17 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/733a5b48ea9b36caa5f300c9b82ed2eaa0a65da289ab238edea3a74897c50b5fc0433d8b82c6c7ba34bef676ad173c52fa3932ae916fea08a7a5f116e4a0b798", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f96f05a611cd1abbccff3f26d6b3a62e1a16bc295397c12e5129a333d2375e0ea3d6254f3e8dca0c9c0827cfe7d27b715b11502ebbe37ae18251de3a48575078", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5525edb553f2de59f2a5318242d5631df8fa07db44bdf3a5fdb8fa0c2998231dbdfb59925536abd841d74e55a85f6ab15831dd855103766a8c48c2b3e0642c13", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/050aa79ab723ab7a756099dcadaf76a4918c830b3dce50deabfa523a9f267af53f163b77ca0ca00bee50a132248a6a749268eceef56f3975efccb6ea990b81a1"} 14:42:17 INFO - Running post-run listener: copy_logs_to_upload_dir 14:42:17 INFO - Copying logs to upload dir... 14:42:17 INFO - mkdir: /builds/slave/test/build/upload/logs 14:42:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.884586 ========= master_lag: -0.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-26 14:42:17.000602) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 14:42:17.007888) ========= 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=5cf47e208febbcd81da23b2e0000026f-1506459664.612733-1226596283 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/733a5b48ea9b36caa5f300c9b82ed2eaa0a65da289ab238edea3a74897c50b5fc0433d8b82c6c7ba34bef676ad173c52fa3932ae916fea08a7a5f116e4a0b798", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f96f05a611cd1abbccff3f26d6b3a62e1a16bc295397c12e5129a333d2375e0ea3d6254f3e8dca0c9c0827cfe7d27b715b11502ebbe37ae18251de3a48575078", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5525edb553f2de59f2a5318242d5631df8fa07db44bdf3a5fdb8fa0c2998231dbdfb59925536abd841d74e55a85f6ab15831dd855103766a8c48c2b3e0642c13", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/050aa79ab723ab7a756099dcadaf76a4918c830b3dce50deabfa523a9f267af53f163b77ca0ca00bee50a132248a6a749268eceef56f3975efccb6ea990b81a1"} build_url:https://queue.taskcluster.net/v1/task/DmeAWeThR7WU_DFoThmLQA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011287 build_url: 'https://queue.taskcluster.net/v1/task/DmeAWeThR7WU_DFoThmLQA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/733a5b48ea9b36caa5f300c9b82ed2eaa0a65da289ab238edea3a74897c50b5fc0433d8b82c6c7ba34bef676ad173c52fa3932ae916fea08a7a5f116e4a0b798", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f96f05a611cd1abbccff3f26d6b3a62e1a16bc295397c12e5129a333d2375e0ea3d6254f3e8dca0c9c0827cfe7d27b715b11502ebbe37ae18251de3a48575078", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5525edb553f2de59f2a5318242d5631df8fa07db44bdf3a5fdb8fa0c2998231dbdfb59925536abd841d74e55a85f6ab15831dd855103766a8c48c2b3e0642c13", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/050aa79ab723ab7a756099dcadaf76a4918c830b3dce50deabfa523a9f267af53f163b77ca0ca00bee50a132248a6a749268eceef56f3975efccb6ea990b81a1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 14:42:17.036318) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 14:42:17.038676) ========= 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=5cf47e208febbcd81da23b2e0000026f-1506459664.612733-1226596283 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004498 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 14:42:17.118178) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 14:42:17.118720) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 14:42:17.119029) ========= ========= Total master_lag: 0.14 =========