builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-035 starttime: 1506724765.36 results: success (0) revision: 64c8107a2a13895e9e4295806bf65b99639cb651 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-29 15:39:25.358732) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-29 15:39:25.359197) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-29 15:39:25.359475) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-29 15:39:25.546101) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 15:39:25.546443) ========= 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=ed14279e38b05397cf4aa391000001a4-1506721513.636646-961579602 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-29 15:39:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 22.6M=0.001s 2017-09-29 15:39:25 (22.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.143589 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 15:39:25.766256) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 15:39:25.766593) ========= 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=ed14279e38b05397cf4aa391000001a4-1506721513.636646-961579602 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021376 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 15:39:25.829430) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 13 secs) (at 2017-09-29 15:39:25.829782) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 64c8107a2a13895e9e4295806bf65b99639cb651 --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 64c8107a2a13895e9e4295806bf65b99639cb651 --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=ed14279e38b05397cf4aa391000001a4-1506721513.636646-961579602 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-29 15:39:25,840 truncating revision to first 12 chars 2017-09-29 15:39:25,840 Setting DEBUG logging. 2017-09-29 15:39:25,840 attempt 1/10 2017-09-29 15:39:25,840 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/64c8107a2a13?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-29 15:39:26,536 attempt 1/10 2017-09-29 15:39:27,417 current task status: no status available at this point. state: STARTED 2017-09-29 15:39:27,418 sleeping for 11.00s (attempt 1/10) 2017-09-29 15:39:38,429 attempt 2/10 2017-09-29 15:39:38,750 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-09-29 15:39:38,917 unpacking tar archive at: mozilla-central-64c8107a2a13/testing/mozharness/ program finished with exit code 0 elapsedTime=13.422389 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 13 secs) (at 2017-09-29 15:39:39.285846) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-29 15:39:39.286189) ========= script_repo_revision: 64c8107a2a13895e9e4295806bf65b99639cb651 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-29 15:39:39.286598) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-29 15:39:39.286893) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-29 15:39:39.303383) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-09-29 15:39:39.303785) ========= /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=ed14279e38b05397cf4aa391000001a4-1506721513.636646-961579602 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:39:39 INFO - MultiFileLogger online at 20170929 15:39:39 in /builds/slave/test 15:39:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 15:39:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:39:39 INFO - {'append_to_log': False, 15:39:39 INFO - 'base_work_dir': '/builds/slave/test', 15:39:39 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:39:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:39:39 INFO - 'branch': 'Firefox-Non-PGO', 15:39:39 INFO - 'buildbot_json_path': 'buildprops.json', 15:39:39 INFO - 'code_coverage': False, 15:39:39 INFO - 'config_files': ('talos/linux_config.py',), 15:39:39 INFO - 'default_actions': ('clobber', 15:39:39 INFO - 'read-buildbot-config', 15:39:39 INFO - 'download-and-extract', 15:39:39 INFO - 'populate-webroot', 15:39:39 INFO - 'create-virtualenv', 15:39:39 INFO - 'install', 15:39:39 INFO - 'setup-mitmproxy', 15:39:39 INFO - 'run-tests'), 15:39:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:39:39 INFO - 'disable_ccov_upload': False, 15:39:39 INFO - 'disable_stylo': False, 15:39:39 INFO - 'download_minidump_stackwalk': True, 15:39:39 INFO - 'download_symbols': 'ondemand', 15:39:39 INFO - 'enable_stylo': False, 15:39:39 INFO - 'enable_webrender': False, 15:39:39 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:39:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:39:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:39:39 INFO - 'gecko_profile': False, 15:39:39 INFO - 'gecko_profile_interval': 0, 15:39:39 INFO - 'installer_path': 'installer.exe', 15:39:39 INFO - 'log_level': 'info', 15:39:39 INFO - 'log_name': 'talos', 15:39:39 INFO - 'log_to_console': True, 15:39:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:39:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:39:39 INFO - 'opt_config_files': (), 15:39:39 INFO - 'pip_index': False, 15:39:39 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 15:39:39 INFO - 'system_bits': '32', 15:39:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:39:39 INFO - 'title': 'talos-linux64-ix-035', 15:39:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:39:39 INFO - 'use_talos_json': True, 15:39:39 INFO - 'verify': 'False', 15:39:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:39:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:39:39 INFO - 'work_dir': 'build'} 15:39:39 INFO - [mozharness: 2017-09-29 22:39:39.436592Z] Running clobber step. 15:39:39 INFO - Running pre-action listener: _resource_record_pre_action 15:39:39 INFO - Running main action method: clobber 15:39:39 INFO - rmtree: /builds/slave/test/build 15:39:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:39:40 INFO - Running post-action listener: _resource_record_post_action 15:39:40 INFO - [mozharness: 2017-09-29 22:39:40.434628Z] Finished clobber step (success) 15:39:40 INFO - [mozharness: 2017-09-29 22:39:40.434725Z] Running read-buildbot-config step. 15:39:40 INFO - Running pre-action listener: _resource_record_pre_action 15:39:40 INFO - Running main action method: read_buildbot_config 15:39:40 INFO - Using buildbot properties: 15:39:40 INFO - { 15:39:40 INFO - "project": "", 15:39:40 INFO - "product": "firefox", 15:39:40 INFO - "who": "kwierso@gmail.com", 15:39:40 INFO - "installer_path": "public/build/target.tar.bz2", 15:39:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 15:39:40 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:39:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 15:39:40 INFO - "stage_platform": "linux64", 15:39:40 INFO - "basedir": "/builds/slave/test", 15:39:40 INFO - "buildnumber": 81, 15:39:40 INFO - "platform": "ubuntu64_hw", 15:39:40 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:39:40 INFO - "slavebuilddir": "test", 15:39:40 INFO - "taskId": "SdtV07GUTiegTm6tC_h-mA", 15:39:40 INFO - "branch": "mozilla-central", 15:39:40 INFO - "script_repo_revision": "production", 15:39:40 INFO - "revision": "64c8107a2a13895e9e4295806bf65b99639cb651", 15:39:40 INFO - "slavename": "talos-linux64-ix-035", 15:39:40 INFO - "repo_path": "mozilla-central" 15:39:40 INFO - } 15:39:40 INFO - Finding installer, test and symbols from parent task. 15:39:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SdtV07GUTiegTm6tC_h-mA'}, attempt #1 15:39:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SdtV07GUTiegTm6tC_h-mA'}, attempt #1 15:39:41 INFO - Task dependencies: G34YYNMNSWCHGxZu1JukKw 15:39:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G34YYNMNSWCHGxZu1JukKw'}, attempt #1 15:39:41 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/G34YYNMNSWCHGxZu1JukKw/artifacts/public/build/target.tar.bz2 15:39:41 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/G34YYNMNSWCHGxZu1JukKw/artifacts/public/build/target.test_packages.json 15:39:41 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/G34YYNMNSWCHGxZu1JukKw/artifacts/public/build/target.crashreporter-symbols.zip 15:39:41 INFO - Running post-action listener: _resource_record_post_action 15:39:41 INFO - [mozharness: 2017-09-29 22:39:41.814339Z] Finished read-buildbot-config step (success) 15:39:41 INFO - [mozharness: 2017-09-29 22:39:41.814557Z] Running download-and-extract step. 15:39:41 INFO - Running pre-action listener: _resource_record_pre_action 15:39:41 INFO - Running main action method: download_and_extract 15:39:41 INFO - mkdir: /builds/slave/test/build/tests 15:39:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:41 INFO - trying https://queue.taskcluster.net/v1/task/G34YYNMNSWCHGxZu1JukKw/artifacts/public/build/target.test_packages.json 15:39:41 INFO - Downloading https://queue.taskcluster.net/v1/task/G34YYNMNSWCHGxZu1JukKw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:39:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G34YYNMNSWCHGxZu1JukKw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:39:42 INFO - Downloaded 989 bytes. 15:39:42 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:39:42 INFO - Using the following test package requirements: 15:39:42 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:39:42 INFO - u'common': [u'target.common.tests.zip'], 15:39:42 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:39:42 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:39:42 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:39:42 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:39:42 INFO - u'mozbase': [u'target.common.tests.zip'], 15:39:42 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:39:42 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:39:42 INFO - u'web-platform': [u'target.common.tests.zip', 15:39:42 INFO - u'target.web-platform.tests.tar.gz'], 15:39:42 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:39:42 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 15:39:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G34YYNMNSWCHGxZu1JukKw/artifacts/public/build/target.common.tests.zip 15:39:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G34YYNMNSWCHGxZu1JukKw/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:39:42 INFO - Fetch https://queue.taskcluster.net/v1/task/G34YYNMNSWCHGxZu1JukKw/artifacts/public/build/target.common.tests.zip into memory 15:39:43 INFO - Content-Length response header: 55366697 15:39:43 INFO - Bytes received: 55366697 15:39:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G34YYNMNSWCHGxZu1JukKw/artifacts/public/build/target.talos.tests.zip 15:39:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G34YYNMNSWCHGxZu1JukKw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:39:54 INFO - Fetch https://queue.taskcluster.net/v1/task/G34YYNMNSWCHGxZu1JukKw/artifacts/public/build/target.talos.tests.zip into memory 15:39:55 INFO - Content-Length response header: 14522385 15:39:55 INFO - Bytes received: 14522385 15:39:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:55 INFO - trying https://queue.taskcluster.net/v1/task/G34YYNMNSWCHGxZu1JukKw/artifacts/public/build/target.tar.bz2 15:39:55 INFO - Downloading https://queue.taskcluster.net/v1/task/G34YYNMNSWCHGxZu1JukKw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:39:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G34YYNMNSWCHGxZu1JukKw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:39:56 INFO - Downloaded 61595023 bytes. 15:39:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/G34YYNMNSWCHGxZu1JukKw/artifacts/public/build/target.tar.bz2 15:39:56 INFO - mkdir: /builds/slave/test/properties 15:39:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:39:56 INFO - Writing to file /builds/slave/test/properties/build_url 15:39:56 INFO - Contents: 15:39:56 INFO - build_url:https://queue.taskcluster.net/v1/task/G34YYNMNSWCHGxZu1JukKw/artifacts/public/build/target.tar.bz2 15:39:56 INFO - Running post-action listener: _resource_record_post_action 15:39:56 INFO - Running post-action listener: find_tests_for_verification 15:39:56 INFO - Running post-action listener: set_extra_try_arguments 15:39:56 INFO - [mozharness: 2017-09-29 22:39:56.785436Z] Finished download-and-extract step (success) 15:39:56 INFO - [mozharness: 2017-09-29 22:39:56.785696Z] Running populate-webroot step. 15:39:56 INFO - Running pre-action listener: _resource_record_pre_action 15:39:56 INFO - Running main action method: populate_webroot 15:39:56 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:39:57 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:39:57 INFO - 'tests': ['tresize', 15:39:57 INFO - 'tcanvasmark']}, 15:39:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:39:57 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:39:57 INFO - 'tests': ['dromaeo_css', 15:39:57 INFO - 'kraken']}, 15:39:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:39:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:39:57 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:39:57 INFO - 'talos_options': ['--disable-stylo'], 15:39:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:39:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:39:57 INFO - 'tests': ['damp', 'tps']}, 15:39:57 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:39:57 INFO - 'talos_options': ['--disable-stylo'], 15:39:57 INFO - 'tests': ['damp', 'tps']}, 15:39:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:39:57 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:39:57 INFO - 'tests': ['dromaeo_dom']}, 15:39:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:39:57 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:39:57 INFO - 'tests': ['basic_compositor_video', 15:39:57 INFO - 'glvideo']}, 15:39:57 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:39:57 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:39:57 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:39:57 INFO - 'talos_options': ['--disable-stylo'], 15:39:57 INFO - 'tests': ['ts_paint_webext', 15:39:57 INFO - 'tp5o_webext']}, 15:39:57 INFO - 'other-e10s': {'tests': ['a11yr', 15:39:57 INFO - 'ts_paint', 15:39:57 INFO - 'tpaint', 15:39:57 INFO - 'sessionrestore', 15:39:57 INFO - 'sessionrestore_many_windows', 15:39:57 INFO - 'sessionrestore_no_auto_restore', 15:39:57 INFO - 'tabpaint', 15:39:57 INFO - 'cpstartup']}, 15:39:57 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:39:57 INFO - 'tests': ['a11yr', 15:39:57 INFO - 'ts_paint', 15:39:57 INFO - 'tpaint', 15:39:57 INFO - 'sessionrestore', 15:39:57 INFO - 'sessionrestore_many_windows', 15:39:57 INFO - 'sessionrestore_no_auto_restore', 15:39:57 INFO - 'tabpaint', 15:39:57 INFO - 'cpstartup']}, 15:39:57 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 15:39:57 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 15:39:57 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:39:57 INFO - 'tests': ['perf_reftest_singletons']}, 15:39:57 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:39:57 INFO - 'tests': ['perf_reftest']}, 15:39:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:39:57 INFO - 'tsvgr_opacity', 15:39:57 INFO - 'tart', 15:39:57 INFO - 'tscrollx', 15:39:57 INFO - 'tsvg_static']}, 15:39:57 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:39:57 INFO - 'tests': ['tsvgx', 15:39:57 INFO - 'tsvgr_opacity', 15:39:57 INFO - 'tart', 15:39:57 INFO - 'tscrollx', 15:39:57 INFO - 'tsvg_static']}, 15:39:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:39:57 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:39:57 INFO - 'talos_options': ['--disable-stylo'], 15:39:57 INFO - 'tests': ['tp5o']}, 15:39:57 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:39:57 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 15:39:57 INFO - 'talos_options': ['--mitmproxy', 15:39:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:39:57 INFO - '--firstNonBlankPaint'], 15:39:57 INFO - 'tests': ['tp6_google', 15:39:57 INFO - 'tp6_youtube', 15:39:57 INFO - 'tp6_amazon', 15:39:57 INFO - 'tp6_facebook']}, 15:39:57 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:39:57 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 15:39:57 INFO - 'talos_options': ['--disable-stylo', 15:39:57 INFO - '--mitmproxy', 15:39:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:39:57 INFO - '--firstNonBlankPaint'], 15:39:57 INFO - 'tests': ['tp6_google', 15:39:57 INFO - 'tp6_youtube', 15:39:57 INFO - 'tp6_amazon', 15:39:57 INFO - 'tp6_facebook']}, 15:39:57 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:39:57 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 15:39:57 INFO - 'talos_options': ['--stylo-threads=1', 15:39:57 INFO - '--mitmproxy', 15:39:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:39:57 INFO - '--firstNonBlankPaint'], 15:39:57 INFO - 'tests': ['tp6_google', 15:39:57 INFO - 'tp6_youtube', 15:39:57 INFO - 'tp6_amazon', 15:39:57 INFO - 'tp6_facebook']}, 15:39:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:39:57 INFO - 'talos_options': ['--xperf_path', 15:39:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:39:57 INFO - 'tests': ['tp5n']}, 15:39:57 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:39:57 INFO - 'talos_options': ['--disable-stylo', 15:39:57 INFO - '--xperf_path', 15:39:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:39:57 INFO - 'tests': ['tp5n']}}} 15:39:57 INFO - Running post-action listener: _resource_record_post_action 15:39:57 INFO - [mozharness: 2017-09-29 22:39:57.122935Z] Finished populate-webroot step (success) 15:39:57 INFO - [mozharness: 2017-09-29 22:39:57.123159Z] Running create-virtualenv step. 15:39:57 INFO - Running pre-action listener: _resource_record_pre_action 15:39:57 INFO - Running main action method: create_virtualenv 15:39:57 INFO - Creating virtualenv /builds/slave/test/build/venv 15:39:57 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:39:57 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:39:57 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:39:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:39:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:39:57 INFO - Installing distribute.............................................................................................................................................................................................done. 15:39:57 INFO - Installing pip...............done. 15:39:57 INFO - Return code: 0 15:39:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:39:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:39:58 INFO - Reading from file tmpfile_stdout 15:39:58 INFO - Output received: 15:39:58 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 15:39:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:39: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')]} 15:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39: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')]} 15:39:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126d9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126ad60>, '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 0x126ba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126bef0>, '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': 'ed14279e38b05397cf4aa391000001a4-1506721513.636646-961579602', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:39: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', 'pip>=1.5'] in /builds/slave/test/build 15:39: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 pip>=1.5 15:39:58 INFO - Using env: {'DISPLAY': ':0', 15:39:58 INFO - 'HOME': '/home/cltbld', 15:39:58 INFO - 'LANG': 'en_US.UTF-8', 15:39:58 INFO - 'LANGUAGE': 'en_US:en', 15:39:58 INFO - 'LOGNAME': 'cltbld', 15:39:58 INFO - 'MAIL': '/var/mail/cltbld', 15:39:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:58 INFO - 'MOZ_NO_REMOTE': '1', 15:39:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:58 INFO - 'NO_EM_RESTART': '1', 15:39:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:58 INFO - 'PWD': '/builds/slave/test', 15:39:58 INFO - 'SHELL': '/bin/bash', 15:39:58 INFO - 'SHLVL': '1', 15:39:58 INFO - 'TERM': 'linux', 15:39:58 INFO - 'TMOUT': '86400', 15:39:58 INFO - 'USER': 'cltbld', 15:39:58 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506721513.636646-961579602', 15:39:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:58 INFO - '_': '/tools/buildbot/bin/python'} 15:39:59 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:39:59 INFO - Downloading/unpacking pip>=1.5 15:39:59 INFO - Running setup.py egg_info for package pip 15:39:59 INFO - warning: no files found matching 'pip/cacert.pem' 15:39:59 INFO - warning: no files found matching '*.html' under directory 'docs' 15:39:59 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:39:59 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:39:59 INFO - Installing collected packages: pip 15:39:59 INFO - Found existing installation: pip 1.1 15:39:59 INFO - Uninstalling pip: 15:39:59 INFO - Successfully uninstalled pip 15:39:59 INFO - Running setup.py install for pip 15:39:59 INFO - warning: no files found matching 'pip/cacert.pem' 15:39:59 INFO - warning: no files found matching '*.html' under directory 'docs' 15:39:59 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:39:59 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:39:59 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:39:59 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:39:59 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:39:59 INFO - Successfully installed pip 15:39:59 INFO - Cleaning up... 15:39:59 INFO - Return code: 0 15:39:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:39:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:59 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 0xf001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126d9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126ad60>, '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 0x126ba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126bef0>, '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': 'ed14279e38b05397cf4aa391000001a4-1506721513.636646-961579602', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:39:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:39:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:39:59 INFO - Using env: {'DISPLAY': ':0', 15:39:59 INFO - 'HOME': '/home/cltbld', 15:39:59 INFO - 'LANG': 'en_US.UTF-8', 15:39:59 INFO - 'LANGUAGE': 'en_US:en', 15:39:59 INFO - 'LOGNAME': 'cltbld', 15:39:59 INFO - 'MAIL': '/var/mail/cltbld', 15:39:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:59 INFO - 'MOZ_NO_REMOTE': '1', 15:39:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:59 INFO - 'NO_EM_RESTART': '1', 15:39:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:59 INFO - 'PWD': '/builds/slave/test', 15:39:59 INFO - 'SHELL': '/bin/bash', 15:39:59 INFO - 'SHLVL': '1', 15:39:59 INFO - 'TERM': 'linux', 15:39:59 INFO - 'TMOUT': '86400', 15:39:59 INFO - 'USER': 'cltbld', 15:39:59 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506721513.636646-961579602', 15:39:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:59 INFO - '_': '/tools/buildbot/bin/python'} 15:39:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:59 INFO - Downloading/unpacking psutil>=3.1.1 15:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:40:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:40:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:40:00 INFO - Installing collected packages: psutil 15:40:00 INFO - Running setup.py install for psutil 15:40:00 INFO - building 'psutil._psutil_linux' extension 15:40:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:40:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:40:01 INFO - building 'psutil._psutil_posix' extension 15:40:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:40:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:40:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:40:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:40:01 INFO - Successfully installed psutil 15:40:01 INFO - Cleaning up... 15:40:01 INFO - Return code: 0 15:40:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:40:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:01 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 0xf001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126d9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126ad60>, '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 0x126ba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126bef0>, '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': 'ed14279e38b05397cf4aa391000001a4-1506721513.636646-961579602', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:40:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:40:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:40:01 INFO - Using env: {'DISPLAY': ':0', 15:40:01 INFO - 'HOME': '/home/cltbld', 15:40:01 INFO - 'LANG': 'en_US.UTF-8', 15:40:01 INFO - 'LANGUAGE': 'en_US:en', 15:40:01 INFO - 'LOGNAME': 'cltbld', 15:40:01 INFO - 'MAIL': '/var/mail/cltbld', 15:40:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:01 INFO - 'MOZ_NO_REMOTE': '1', 15:40:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:01 INFO - 'NO_EM_RESTART': '1', 15:40:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:01 INFO - 'PWD': '/builds/slave/test', 15:40:01 INFO - 'SHELL': '/bin/bash', 15:40:01 INFO - 'SHLVL': '1', 15:40:01 INFO - 'TERM': 'linux', 15:40:01 INFO - 'TMOUT': '86400', 15:40:01 INFO - 'USER': 'cltbld', 15:40:01 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506721513.636646-961579602', 15:40:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:01 INFO - '_': '/tools/buildbot/bin/python'} 15:40:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:40:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:40:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:40:02 INFO - Installing collected packages: mozsystemmonitor 15:40:02 INFO - Running setup.py install for mozsystemmonitor 15:40:02 INFO - Successfully installed mozsystemmonitor 15:40:02 INFO - Cleaning up... 15:40:03 INFO - Return code: 0 15:40:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:40:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xf001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126d9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126ad60>, '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 0x126ba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126bef0>, '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': 'ed14279e38b05397cf4aa391000001a4-1506721513.636646-961579602', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:40:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:40:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:40:03 INFO - Using env: {'DISPLAY': ':0', 15:40:03 INFO - 'HOME': '/home/cltbld', 15:40:03 INFO - 'LANG': 'en_US.UTF-8', 15:40:03 INFO - 'LANGUAGE': 'en_US:en', 15:40:03 INFO - 'LOGNAME': 'cltbld', 15:40:03 INFO - 'MAIL': '/var/mail/cltbld', 15:40:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:03 INFO - 'MOZ_NO_REMOTE': '1', 15:40:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:03 INFO - 'NO_EM_RESTART': '1', 15:40:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:03 INFO - 'PWD': '/builds/slave/test', 15:40:03 INFO - 'SHELL': '/bin/bash', 15:40:03 INFO - 'SHLVL': '1', 15:40:03 INFO - 'TERM': 'linux', 15:40:03 INFO - 'TMOUT': '86400', 15:40:03 INFO - 'USER': 'cltbld', 15:40:03 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506721513.636646-961579602', 15:40:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:03 INFO - '_': '/tools/buildbot/bin/python'} 15:40:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:03 INFO - Downloading/unpacking jsonschema==2.5.1 15:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:40:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:40: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 15:40: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 15:40: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 15:40: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 15:40:04 INFO - Downloading functools32-3.2.3-2.tar.gz 15:40:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:40:04 INFO - warning: no files found matching '*.txt' 15:40:04 INFO - no previously-included directories found matching 'build' 15:40:04 INFO - no previously-included directories found matching 'dist' 15:40:04 INFO - no previously-included directories found matching '.git*' 15:40:04 INFO - Installing collected packages: jsonschema, functools32 15:40:05 INFO - Running setup.py install for functools32 15:40:06 INFO - warning: no files found matching '*.txt' 15:40:06 INFO - no previously-included directories found matching 'build' 15:40:06 INFO - no previously-included directories found matching 'dist' 15:40:06 INFO - no previously-included directories found matching '.git*' 15:40:06 INFO - Successfully installed jsonschema functools32 15:40:06 INFO - Cleaning up... 15:40:06 INFO - Return code: 0 15:40:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:40:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xf001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126d9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126ad60>, '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 0x126ba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126bef0>, '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': 'ed14279e38b05397cf4aa391000001a4-1506721513.636646-961579602', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:40:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:40:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:40:06 INFO - Using env: {'DISPLAY': ':0', 15:40:06 INFO - 'HOME': '/home/cltbld', 15:40:06 INFO - 'LANG': 'en_US.UTF-8', 15:40:06 INFO - 'LANGUAGE': 'en_US:en', 15:40:06 INFO - 'LOGNAME': 'cltbld', 15:40:06 INFO - 'MAIL': '/var/mail/cltbld', 15:40:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:06 INFO - 'MOZ_NO_REMOTE': '1', 15:40:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:06 INFO - 'NO_EM_RESTART': '1', 15:40:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:06 INFO - 'PWD': '/builds/slave/test', 15:40:06 INFO - 'SHELL': '/bin/bash', 15:40:06 INFO - 'SHLVL': '1', 15:40:06 INFO - 'TERM': 'linux', 15:40:06 INFO - 'TMOUT': '86400', 15:40:06 INFO - 'USER': 'cltbld', 15:40:06 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506721513.636646-961579602', 15:40:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:06 INFO - '_': '/tools/buildbot/bin/python'} 15:40:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:40:06 INFO - Cleaning up... 15:40:06 INFO - Return code: 0 15:40:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:40:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xf001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126d9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126ad60>, '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 0x126ba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126bef0>, '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': 'ed14279e38b05397cf4aa391000001a4-1506721513.636646-961579602', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:40:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:40:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:40:06 INFO - Using env: {'DISPLAY': ':0', 15:40:06 INFO - 'HOME': '/home/cltbld', 15:40:06 INFO - 'LANG': 'en_US.UTF-8', 15:40:06 INFO - 'LANGUAGE': 'en_US:en', 15:40:06 INFO - 'LOGNAME': 'cltbld', 15:40:06 INFO - 'MAIL': '/var/mail/cltbld', 15:40:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:06 INFO - 'MOZ_NO_REMOTE': '1', 15:40:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:06 INFO - 'NO_EM_RESTART': '1', 15:40:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:06 INFO - 'PWD': '/builds/slave/test', 15:40:06 INFO - 'SHELL': '/bin/bash', 15:40:06 INFO - 'SHLVL': '1', 15:40:06 INFO - 'TERM': 'linux', 15:40:06 INFO - 'TMOUT': '86400', 15:40:06 INFO - 'USER': 'cltbld', 15:40:06 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506721513.636646-961579602', 15:40:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:06 INFO - '_': '/tools/buildbot/bin/python'} 15:40:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:06 INFO - Downloading/unpacking blobuploader==1.2.4 15:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:07 INFO - Downloading blobuploader-1.2.4.tar.gz 15:40:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:40:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:40: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 15:40: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 15:40: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 15:40: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 15:40:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:40:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:08 INFO - Downloading docopt-0.6.1.tar.gz 15:40:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:40:08 INFO - Installing collected packages: blobuploader, requests, docopt 15:40:08 INFO - Running setup.py install for blobuploader 15:40:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:40:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:40:08 INFO - Running setup.py install for requests 15:40:08 INFO - Running setup.py install for docopt 15:40:08 INFO - Successfully installed blobuploader requests docopt 15:40:08 INFO - Cleaning up... 15:40:08 INFO - Return code: 0 15:40:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:40:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:08 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 0xf001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126d9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126ad60>, '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 0x126ba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126bef0>, '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': 'ed14279e38b05397cf4aa391000001a4-1506721513.636646-961579602', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:40:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:40:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:40:08 INFO - Using env: {'DISPLAY': ':0', 15:40:08 INFO - 'HOME': '/home/cltbld', 15:40:08 INFO - 'LANG': 'en_US.UTF-8', 15:40:08 INFO - 'LANGUAGE': 'en_US:en', 15:40:08 INFO - 'LOGNAME': 'cltbld', 15:40:08 INFO - 'MAIL': '/var/mail/cltbld', 15:40:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:08 INFO - 'MOZ_NO_REMOTE': '1', 15:40:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:08 INFO - 'NO_EM_RESTART': '1', 15:40:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:08 INFO - 'PWD': '/builds/slave/test', 15:40:08 INFO - 'SHELL': '/bin/bash', 15:40:08 INFO - 'SHLVL': '1', 15:40:08 INFO - 'TERM': 'linux', 15:40:08 INFO - 'TMOUT': '86400', 15:40:08 INFO - 'USER': 'cltbld', 15:40:08 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506721513.636646-961579602', 15:40:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:08 INFO - '_': '/tools/buildbot/bin/python'} 15:40:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:40:09 INFO - Running setup.py (path:/tmp/pip-cYzSfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:40:09 INFO - Running setup.py (path:/tmp/pip-D9JqiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:40:09 INFO - Running setup.py (path:/tmp/pip-bEldi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:40:09 INFO - Running setup.py (path:/tmp/pip-TFCnK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:40:09 INFO - Running setup.py (path:/tmp/pip-U2agnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:40:09 INFO - Running setup.py (path:/tmp/pip-cylBvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:40:09 INFO - Running setup.py (path:/tmp/pip-v4ZTU2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:40:09 INFO - Running setup.py (path:/tmp/pip-GLqfqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:40:09 INFO - Running setup.py (path:/tmp/pip-inyNwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:40:09 INFO - Running setup.py (path:/tmp/pip-R5yUV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:40:09 INFO - Running setup.py (path:/tmp/pip-voZ5jE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:40:09 INFO - Running setup.py (path:/tmp/pip-wNSIQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:40:09 INFO - Running setup.py (path:/tmp/pip-3IOhkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:40:10 INFO - Running setup.py (path:/tmp/pip-SyezyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:40:10 INFO - Running setup.py (path:/tmp/pip-J7iOk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:40:10 INFO - Running setup.py (path:/tmp/pip-wKXkyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:40:10 INFO - Running setup.py (path:/tmp/pip-dYPMDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:40:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:40:10 INFO - Running setup.py install for manifestparser 15:40:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:40:10 INFO - Running setup.py install for mozcrash 15:40:10 INFO - Running setup.py install for mozdebug 15:40:10 INFO - Running setup.py install for mozdevice 15:40:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:40:10 INFO - Running setup.py install for mozfile 15:40:10 INFO - Running setup.py install for mozhttpd 15:40:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:40:10 INFO - Running setup.py install for mozinfo 15:40:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:40:11 INFO - Running setup.py install for mozInstall 15:40:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:40:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:40:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:40:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:40:11 INFO - Running setup.py install for mozleak 15:40:11 INFO - Running setup.py install for mozlog 15:40:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:40:11 INFO - Running setup.py install for moznetwork 15:40:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:40:11 INFO - Running setup.py install for mozprocess 15:40:11 INFO - Running setup.py install for mozprofile 15:40:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:40:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:40:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:40:11 INFO - Running setup.py install for mozrunner 15:40:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:40:11 INFO - Running setup.py install for mozscreenshot 15:40:11 INFO - Running setup.py install for moztest 15:40:11 INFO - Running setup.py install for mozversion 15:40:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:40:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:40:12 INFO - Cleaning up... 15:40:12 INFO - Return code: 0 15:40:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:40: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')]} 15:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40: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')]} 15:40:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40: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 0xf001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126d9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126ad60>, '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 0x126ba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126bef0>, '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': 'ed14279e38b05397cf4aa391000001a4-1506721513.636646-961579602', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:40: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 15:40: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 15:40:12 INFO - Using env: {'DISPLAY': ':0', 15:40:12 INFO - 'HOME': '/home/cltbld', 15:40:12 INFO - 'LANG': 'en_US.UTF-8', 15:40:12 INFO - 'LANGUAGE': 'en_US:en', 15:40:12 INFO - 'LOGNAME': 'cltbld', 15:40:12 INFO - 'MAIL': '/var/mail/cltbld', 15:40:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:12 INFO - 'MOZ_NO_REMOTE': '1', 15:40:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:12 INFO - 'NO_EM_RESTART': '1', 15:40:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:12 INFO - 'PWD': '/builds/slave/test', 15:40:12 INFO - 'SHELL': '/bin/bash', 15:40:12 INFO - 'SHLVL': '1', 15:40:12 INFO - 'TERM': 'linux', 15:40:12 INFO - 'TMOUT': '86400', 15:40:12 INFO - 'USER': 'cltbld', 15:40:12 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506721513.636646-961579602', 15:40:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:12 INFO - '_': '/tools/buildbot/bin/python'} 15:40:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:40:12 INFO - Running setup.py (path:/tmp/pip-FZq0ym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:40:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:40:12 INFO - Running setup.py (path:/tmp/pip-yCrH6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:40:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:40:12 INFO - Running setup.py (path:/tmp/pip-ZiGBpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:40:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:40:12 INFO - Running setup.py (path:/tmp/pip-OaAuJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:40:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:40:12 INFO - Running setup.py (path:/tmp/pip-xEg4fC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:40:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:40:12 INFO - Running setup.py (path:/tmp/pip-FlmMo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:40:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:40:12 INFO - Running setup.py (path:/tmp/pip-IAX2P5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:40:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:40:12 INFO - Running setup.py (path:/tmp/pip-rt013_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:40:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:40:12 INFO - Running setup.py (path:/tmp/pip-gKc3lz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:40:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:40:12 INFO - Running setup.py (path:/tmp/pip-iom6mw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:40: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)) 15:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:40:13 INFO - Running setup.py (path:/tmp/pip-LJ08cX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:40: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)) 15:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:40:13 INFO - Running setup.py (path:/tmp/pip-5zeziW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:40: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)) 15:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:40:13 INFO - Running setup.py (path:/tmp/pip-jvsDyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:40: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)) 15:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:40:13 INFO - Running setup.py (path:/tmp/pip-UIVcac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:40: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)) 15:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:40:13 INFO - Running setup.py (path:/tmp/pip-SK0QZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:40:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:40:13 INFO - Running setup.py (path:/tmp/pip-Q1ll4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:40:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:40:13 INFO - Running setup.py (path:/tmp/pip-0_mm58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:40:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:40:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:40:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:40:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:40:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:40:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:40:13 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:40:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:40:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:14 INFO - Downloading blessings-1.6.tar.gz 15:40:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:40:14 INFO - Installing collected packages: blessings 15:40:14 INFO - Running setup.py install for blessings 15:40:14 INFO - Successfully installed blessings 15:40:14 INFO - Cleaning up... 15:40:14 INFO - Return code: 0 15:40:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:40:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:40:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:40:15 INFO - Reading from file tmpfile_stdout 15:40:15 INFO - Current package versions: 15:40:15 INFO - argparse == 1.2.1 15:40:15 INFO - blessings == 1.6 15:40:15 INFO - blobuploader == 1.2.4 15:40:15 INFO - docopt == 0.6.1 15:40:15 INFO - functools32 == 3.2.3-2 15:40:15 INFO - jsonschema == 2.5.1 15:40:15 INFO - manifestparser == 1.1 15:40:15 INFO - mozInstall == 1.13 15:40:15 INFO - mozcrash == 1.0 15:40:15 INFO - mozdebug == 0.1 15:40:15 INFO - mozdevice == 0.51 15:40:15 INFO - mozfile == 1.2 15:40:15 INFO - mozhttpd == 0.7 15:40:15 INFO - mozinfo == 0.10 15:40:15 INFO - mozleak == 0.1 15:40:15 INFO - mozlog == 3.5 15:40:15 INFO - moznetwork == 0.27 15:40:15 INFO - mozprocess == 0.25 15:40:15 INFO - mozprofile == 0.28 15:40:15 INFO - mozrunner == 6.13 15:40:15 INFO - mozscreenshot == 0.1 15:40:15 INFO - mozsystemmonitor == 0.3 15:40:15 INFO - moztest == 0.8 15:40:15 INFO - mozversion == 1.4 15:40:15 INFO - psutil == 3.1.1 15:40:15 INFO - requests == 1.2.3 15:40:15 INFO - wsgiref == 0.1.2 15:40:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:40: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')]} 15:40:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40: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')]} 15:40:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40: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 0xf001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126d9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126ad60>, '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 0x126ba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126bef0>, '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': 'ed14279e38b05397cf4aa391000001a4-1506721513.636646-961579602', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:40: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 15:40: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 15:40:15 INFO - Using env: {'DISPLAY': ':0', 15:40:15 INFO - 'HOME': '/home/cltbld', 15:40:15 INFO - 'LANG': 'en_US.UTF-8', 15:40:15 INFO - 'LANGUAGE': 'en_US:en', 15:40:15 INFO - 'LOGNAME': 'cltbld', 15:40:15 INFO - 'MAIL': '/var/mail/cltbld', 15:40:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:15 INFO - 'MOZ_NO_REMOTE': '1', 15:40:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:15 INFO - 'NO_EM_RESTART': '1', 15:40:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:15 INFO - 'PWD': '/builds/slave/test', 15:40:15 INFO - 'SHELL': '/bin/bash', 15:40:15 INFO - 'SHLVL': '1', 15:40:15 INFO - 'TERM': 'linux', 15:40:15 INFO - 'TMOUT': '86400', 15:40:15 INFO - 'USER': 'cltbld', 15:40:15 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506721513.636646-961579602', 15:40:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:15 INFO - '_': '/tools/buildbot/bin/python'} 15:40:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40: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)) 15:40: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)) 15:40: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)) 15:40: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)) 15:40: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)) 15:40: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)) 15:40: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)) 15:40: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)) 15:40: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)) 15:40:15 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:40: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 15:40:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40: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 15:40:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:40:16 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:40:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:40:16 INFO - Installing collected packages: simplejson 15:40:16 INFO - Running setup.py install for simplejson 15:40:16 INFO - building 'simplejson._speedups' extension 15:40:16 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 15:40:17 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 15:40:17 INFO - Successfully installed simplejson 15:40:17 INFO - Cleaning up... 15:40:17 INFO - Return code: 0 15:40:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:40:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:17 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 0xf001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126d9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126ad60>, '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 0x126ba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126bef0>, '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': 'ed14279e38b05397cf4aa391000001a4-1506721513.636646-961579602', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:40:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:40:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:40:17 INFO - Using env: {'DISPLAY': ':0', 15:40:17 INFO - 'HOME': '/home/cltbld', 15:40:17 INFO - 'LANG': 'en_US.UTF-8', 15:40:17 INFO - 'LANGUAGE': 'en_US:en', 15:40:17 INFO - 'LOGNAME': 'cltbld', 15:40:17 INFO - 'MAIL': '/var/mail/cltbld', 15:40:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:17 INFO - 'MOZ_NO_REMOTE': '1', 15:40:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:17 INFO - 'NO_EM_RESTART': '1', 15:40:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:17 INFO - 'PWD': '/builds/slave/test', 15:40:17 INFO - 'SHELL': '/bin/bash', 15:40:17 INFO - 'SHLVL': '1', 15:40:17 INFO - 'TERM': 'linux', 15:40:17 INFO - 'TMOUT': '86400', 15:40:17 INFO - 'USER': 'cltbld', 15:40:17 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506721513.636646-961579602', 15:40:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:17 INFO - '_': '/tools/buildbot/bin/python'} 15:40:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:40:17 INFO - Cleaning up... 15:40:17 INFO - Return code: 0 15:40:17 INFO - Running post-action listener: _resource_record_post_action 15:40:17 INFO - Running post-action listener: _start_resource_monitoring 15:40:17 INFO - Starting resource monitoring. 15:40:17 INFO - [mozharness: 2017-09-29 22:40:17.806646Z] Finished create-virtualenv step (success) 15:40:17 INFO - [mozharness: 2017-09-29 22:40:17.807214Z] Running install step. 15:40:17 INFO - Running pre-action listener: _resource_record_pre_action 15:40:17 INFO - Running main action method: install 15:40:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:40:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:40:18 INFO - Reading from file tmpfile_stdout 15:40:18 INFO - Detecting whether we're running mozinstall >=1.0... 15:40:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:40:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:40:18 INFO - Reading from file tmpfile_stdout 15:40:18 INFO - Output received: 15:40:18 INFO - Usage: mozinstall [options] installer 15:40:18 INFO - Options: 15:40:18 INFO - -h, --help show this help message and exit 15:40:18 INFO - -d DEST, --destination=DEST 15:40:18 INFO - Directory to install application into. [default: 15:40:18 INFO - "/builds/slave/test"] 15:40:18 INFO - --app=APP Application being installed. [default: firefox] 15:40:18 INFO - mkdir: /builds/slave/test/build/application 15:40: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'] 15:40:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:40:35 INFO - Reading from file tmpfile_stdout 15:40:35 INFO - Output received: 15:40:35 INFO - /builds/slave/test/build/application/firefox/firefox 15:40:35 INFO - Running post-action listener: _resource_record_post_action 15:40:35 INFO - [mozharness: 2017-09-29 22:40:35.930567Z] Finished install step (success) 15:40:35 INFO - [mozharness: 2017-09-29 22:40:35.930821Z] Running setup-mitmproxy step. 15:40:35 INFO - Running pre-action listener: _resource_record_pre_action 15:40:35 INFO - Running main action method: setup_mitmproxy 15:40:35 INFO - Skipping: mitmproxy is not required 15:40:35 INFO - Running post-action listener: _resource_record_post_action 15:40:35 INFO - [mozharness: 2017-09-29 22:40:35.931970Z] Finished setup-mitmproxy step (success) 15:40:35 INFO - [mozharness: 2017-09-29 22:40:35.932190Z] Running run-tests step. 15:40:35 INFO - Running pre-action listener: _resource_record_pre_action 15:40:35 INFO - Running pre-action listener: _set_gcov_prefix 15:40:35 INFO - Running main action method: run_tests 15:40:35 WARNING - Try message not found. 15:40:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:40:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:40:35 INFO - Python 2.7.3 15:40:35 INFO - Return code: 0 15:40:35 INFO - grabbing minidump binary from tooltool 15:40:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:35 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 0x126ad60>, '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 0x126ba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126bef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:40:35 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:40:35 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:40:35 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:40:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:40:36 INFO - Return code: 0 15:40:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:40:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:40:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:40:36 INFO - ENV: RUST_BACKTRACE is now full 15:40:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:40:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:40: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/G34YYNMNSWCHGxZu1JukKw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 15:40: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/G34YYNMNSWCHGxZu1JukKw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 15:40:36 INFO - Using env: {'DISPLAY': ':0', 15:40:36 INFO - 'HOME': '/home/cltbld', 15:40:36 INFO - 'LANG': 'en_US.UTF-8', 15:40:36 INFO - 'LANGUAGE': 'en_US:en', 15:40:36 INFO - 'LOGNAME': 'cltbld', 15:40:36 INFO - 'MAIL': '/var/mail/cltbld', 15:40:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:40:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:40:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:36 INFO - 'MOZ_NO_REMOTE': '1', 15:40:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:40:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:36 INFO - 'NO_EM_RESTART': '1', 15:40:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:36 INFO - 'PWD': '/builds/slave/test', 15:40:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:40:36 INFO - 'RUST_BACKTRACE': 'full', 15:40:36 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:40:36 INFO - 'SHELL': '/bin/bash', 15:40:36 INFO - 'SHLVL': '1', 15:40:36 INFO - 'TERM': 'linux', 15:40:36 INFO - 'TMOUT': '86400', 15:40:36 INFO - 'USER': 'cltbld', 15:40:36 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506721513.636646-961579602', 15:40:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:36 INFO - '_': '/tools/buildbot/bin/python'} 15:40: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/G34YYNMNSWCHGxZu1JukKw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 15:40:36 INFO - mozversion application_buildid: 20170929214553 15:40:36 INFO - mozversion application_changeset: 64c8107a2a13895e9e4295806bf65b99639cb651 15:40:36 INFO - mozversion application_display_name: Nightly 15:40:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:40:36 INFO - mozversion application_name: Firefox 15:40:36 INFO - mozversion application_remotingname: firefox 15:40:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:40:36 INFO - mozversion application_vendor: Mozilla 15:40:36 INFO - mozversion application_version: 58.0a1 15:40:36 INFO - mozversion platform_buildid: 20170929214553 15:40:36 INFO - mozversion platform_changeset: 64c8107a2a13895e9e4295806bf65b99639cb651 15:40:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:40:36 INFO - mozversion platform_version: 58.0a1 15:40:36 INFO - using testdate: 1506724836 15:40:36 INFO - actual date: 1506724836 15:40:36 INFO - starting webserver on 'localhost:35201' 15:40:36 INFO - SUITE-START | Running 2 tests 15:40:36 INFO - TEST-START | dromaeo_css 15:40:36 INFO - Initialising browser for dromaeo_css test... 15:40:36 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35201/getInfo.html -profile /tmp/tmpJyFpFC/profile 15:40:36 INFO - TEST-INFO | started process 20262 (/builds/slave/test/build/application/firefox/firefox http://localhost:35201/getInfo.html) 15:40:41 INFO - TEST-INFO | 20262: exit 0 15:40:41 INFO - Browser initialized. 15:40:41 INFO - Running cycle 1/1 for dromaeo_css test... 15:40:41 INFO - Using env: {'DISPLAY': ':0', 15:40:41 INFO - 'HOME': '/home/cltbld', 15:40:41 INFO - 'JSGC_DISABLE_POISONING': '1', 15:40:41 INFO - 'LANG': 'en_US.UTF-8', 15:40:41 INFO - 'LANGUAGE': 'en_US:en', 15:40:41 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:40:41 INFO - 'LOGNAME': 'cltbld', 15:40:41 INFO - 'MAIL': '/var/mail/cltbld', 15:40:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:40:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:40:41 INFO - 'MOZ_CRASHREPORTER': '1', 15:40:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:41 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:40:41 INFO - 'MOZ_NO_REMOTE': '1', 15:40:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:40:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:41 INFO - 'NO_EM_RESTART': '1', 15:40:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:41 INFO - 'PWD': '/builds/slave/test', 15:40:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:40:41 INFO - 'RUST_BACKTRACE': 'full', 15:40:41 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:40:41 INFO - 'SHELL': '/bin/bash', 15:40:41 INFO - 'SHLVL': '1', 15:40:41 INFO - 'STYLO_FORCE_DISABLED': '1', 15:40:41 INFO - 'TERM': 'linux', 15:40:41 INFO - 'TMOUT': '86400', 15:40:41 INFO - 'USER': 'cltbld', 15:40:41 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506721513.636646-961579602', 15:40:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:41 INFO - '_': '/tools/buildbot/bin/python'} 15:40:41 INFO - TEST-INFO | started process 20493 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJyFpFC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:40:42 INFO - PID 20493 | 15:40:42 INFO - PID 20493 | (/builds/slave/test/build/application/firefox/firefox:20542): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:40:42 INFO - PID 20493 | 15:40:52 INFO - PID 20493 | RSS: Main: 153690112 15:40:52 INFO - PID 20493 | 15:43:49 INFO - PID 20493 | Cycle 1(1): loaded http://localhost:35201/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35201/tests/dromaeo/cssquery-ext.html) 15:43:50 INFO - PID 20493 | RSS: Main: 151465984 15:43:50 INFO - PID 20493 | 15:46:52 INFO - PID 20493 | Cycle 1(1): loaded http://localhost:35201/tests/dromaeo/cssquery-ext.html (next: http://localhost:35201/tests/dromaeo/cssquery-jquery.html) 15:46:53 INFO - PID 20493 | RSS: Main: 151928832 15:46:53 INFO - PID 20493 | 15:49:54 INFO - PID 20493 | Cycle 1(1): loaded http://localhost:35201/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35201/tests/dromaeo/cssquery-mootools.html) 15:49:55 INFO - PID 20493 | RSS: Main: 153141248 15:49:55 INFO - PID 20493 | 15:52:57 INFO - PID 20493 | Cycle 1(1): loaded http://localhost:35201/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35201/tests/dromaeo/cssquery-prototype.html) 15:52:57 INFO - PID 20493 | RSS: Main: 151334912 15:52:57 INFO - PID 20493 | 15:56:01 INFO - PID 20493 | Cycle 1(1): loaded http://localhost:35201/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35201/tests/dromaeo/cssquery-yui.html) 15:56:01 INFO - PID 20493 | RSS: Main: 155545600 15:56:01 INFO - PID 20493 | 15:59:03 INFO - PID 20493 | Cycle 1(1): loaded http://localhost:35201/tests/dromaeo/cssquery-yui.html (next: http://localhost:35201/tests/dromaeo/cssquery-dojo.html) 15:59:03 INFO - PID 20493 | RSS: Main: 155553792 15:59:03 INFO - PID 20493 | 15:59:03 INFO - PID 20493 | __start_tp_report 15:59:03 INFO - PID 20493 | _x_x_mozilla_page_load 15:59:03 INFO - PID 20493 | _x_x_mozilla_page_load_details 15:59:03 INFO - PID 20493 | |i|pagename|runs| 15:59:03 INFO - PID 20493 | |0;dojo.html;3071.815691058538;3073.10879844845;3106.3631955449137;3142.764292678049;3156.621205455345;6310.936890631092;6341.6829158542005;6375.043743438487;6440.806775796727;6480.189976252975;6312.210973628296;6341.3341599132;6354.459870910967;6390.936090639092;6395.360463953602;5861.413858614126;5869.706514674271;5876.030454974924;5883.117532370136;5990;5948.167256584082;5969.074793407029;5979.222701048858;5997.190379298804;6031.276246850384;5889.116632505115;5956.52347812174;6013.51891848651;6024.759009639609;6024.849378765544;591.927841177457;5446.8910621787345;5828.854278643025;5834.504067154255;5967.4629283364275;5852.092925596539;5873.442023007808;5926.733297001645;5930.3773103823905;5934.97032514839;6294.685265736741;6396.840078998062;6415.903761443582;6474.74101035958;6489;6839.452843772487;6845.657717114174;6856.862862742767;6928.099347084847;6944.72221111155;6914.308569143096;6919.204291506491;6969.6166710830885;6989.685464154125;6995.685194166274;6255.280642726099;6263.4989200864275;6354.777582784581;6357.268914074848;6360.395762402518;7092.716291348288;7094.361507464353;7102.325279098581;7148.678309476086;7158.534695244793;6743.2919543448215;6808.557443766238;6825.931740682529;6826.385625293748;6831.28271531492;6862.656867156622;6889.724411023503;6890.345417185359;6955.408790252784;6981.965090174516;6647.235567909753;6768.289329620417;6784.728610855511;6863.210730766026;6873.553219040847;6876.140482439695;6906.965465172742;6919.654017299215;6947.444204463631;6978.965105174543;5336.359636843604;5341.5192632662465;5396.379416367168;5396.9730151348995;5431.158170483582;4560.452745670541;4674.5325467452985;4710.576048155683;4739.957209413923;4741.83403580873;5816;5846.181534585162;5920.911186332209;5921.970390148022;5929.3181284152015;6897.620630865351;6914.688839002257;6968.338007889242;6974.093367862247;6998.440124790005;5762.30852297727;5848.239728835224;5850.12248162779;5890.705464726832;5898.262717160355;5832.708364581754;5834.620749651259;5910.674912879833;5922.200502932135;5943.791967281124;6643.900341494881;6658.300878407795;6729.158855143107;6737.393634572814;6761.763338283136;6723.596584204964;6821.89767153503;6826.180858297036;6901;6970.233274339818;6556.704948277435;6569.146011018537;6573.934260657332;6596.142501474777;6600.570962887397;6710.798676039727;6793.966030169818;6814.897776533455;6825.112735344572;6843.931560684329;6939.653017349214;6952.165740111219;6978.476614254053;7034.577925324497;7040.57756534589;6626.403623673892;6626.602403855784;6717;6719.059331693469;6719.227288861648;6433;6551.148350714377;6644.169478815148;6709.36261055199;6730.259671436236;6586.736530538725;6647.4682025438815;6700.363465470772;6713.160854893138;6719.428848547928;6740.6966686498245;6743.561668491532;6761.053452516553;6798.218204906301;6827.146606674166;6484.610923344614;6510.18622672166;6555.508336874658;6560.3111673275525;6592.43964263043 15:59:03 INFO - PID 20493 | |1;ext.html;884.1158841158841;901.179926267097;908.500324821348;909.4406939732063;911.6353458616557;38835.61164388359;42627.57372426275;42704.14591708164;42783.78608106959;42790.78604606973;39136.60863391365;39259.21481570367;39267.41098883519;39553.01117472065;39564.60435395645;7318.8902166467415;7493.475456718032;7495.138059123189;7502.32479076883;7506.361959233472;7224.3136901994485;7344.192138864747;7363.631818409085;7367.926320736778;7379.335859772619;7310.671019804122;7313.7074517019255;7339.155997060353;7367.484276100675;8049.47678400905;8112.553809540473;8196.918030819736;8198.877016844752;8200.220979007014;8202.097769245378;7867.370610351159;8009.9199008009755;8026.799330016738;8103.554304513249;8107.594620268963;38449.23101537982;38889.805550972065;38898.22203555941;38931.22137557233;39020.41469377962;3563.3585954528176;3578.5526809148855;3607.7654952428006;3609.2781443711365;3610.963890361089;31201.21996950072;31509;31826.522602160985;31958.520622190685;31975.360492790012;5193.454687257821;5212.713300768456;5216.608754343401;5226.895462090775;5253.185756207756;187679;188530;189323.05338473356;190002;190111.04944475327;42621;43501.564984350385;48964.51035489671;49126.754366228655;50105.74947125314;52116.436506904094;52432.47567524276;52495;52509;52530.474695253324;15202.315895784715;15344.079355238722;15651.295691693673;15786.921065394828;15835.604109897115;13219.66950826237;13264.071514994052;13284.136531125447;13310.866891331156;13463.461461541625;14242.504537023671;14366.066205696596;14390.568282951528;14429.494967676292;14655.413783448756;5782.248307720053;5871.706414679249;5904.380040095814;5924.200232968494;6036.245469316335;1011.3881101933224;1019.3374306700704;1019.8164330420595;1027.3630349183404;1034.255336157965;22784;22806.885965570065;22824.429389265402;23254.06983720666;23752.524949500912;1120.4621781544904;1125.3472985668293;1128.7403897103711;1135.3415019288793;1135.9318440893574;12255.264684118982;12267.815982760265;12347.320897350732;12367.257964522158;12433.37833108341;229919;230862;231684;231773;231901;52739.20891186635;52890;52912.20631690528;52993.470065299625;53185.2022219667;1382.9654258643614;1437.805896203999;1458.5259790568107;1459.9343029563695;1467.3030310602378;23172.53654926858;23283.534329313658;23300.184493542645;23337.299881003597;23892.88053559721;36441.81779091193;36536;36583.26833463369;36625;36723.816380917924;191767;192901;193001;193233;193951;33872.66127338695;33915.49126763051;35690.64309356977;35850.64149358473;35862.28275434529;45855.082898342516;45997.77001114973;46058;46067.539324606325;46379.30431043605;32949.83525082359;33018.504722429665;33287;33330.00019998711;33459.49810752792;32550.837245814568;33126.503102453964;33263.50104748479;33338.833305833316;33651.3269734599;37115;37161.814190928875;37407.43888841615;37418;37469.81265093657;31938.19958380541;31952.201194970312;32111.197220069684;32261.193470163435;32340.35319293648;23962.88018559896;24200.394990125387;24212.39469013289;24436.87781561081;24785 15:59:03 INFO - PID 20493 | |2;jquery.html;577.3331801768958;586.2964442668793;593.6075329491953;604.5435696049483;605.4187979539643;22440.43898902526;23383.766162338372;23400.414989625267;23410.297691069274;23413;24347.26958191257;24525.877370613165;25887.22338329853;26100.869495652543;26152.86923565384;6545.149130613026;6632.137822083122;6680;6699.564528305645;6726.529142959995;6354.650494222816;6538.542302038859;6623.503237257225;6648.900266496006;6660.034295027218;6528.934710652904;6585.440237579812;6586;6611.338866113374;6616.470682345401;6327.588706734071;6609.504287178481;6612.338766123373;6616.0406741022525;6631.93368066318;6107.572469927107;6117.051856962178;6119.602225855305;6121.051237058263;6153.661548614825;29019.85490072557;29497.41005179906;29522.55716164259;29597.852010740025;29644.70355296441;2040.8571400002006;2072.7409073865765;2080.9895950520304;2090.1221486975355;2098.548812005411;19616;19782.30761923326;20160.79839201604;20312.79687203124;20350.592988140153;2394.199467298024;2434.720007199177;2437.195725410628;2459.6802415685847;2476.1828596563273;122843;123309.38345308306;128190;129704;130645;14771.187584682946;15082;15266.923665381602;15590.298436570381;15594.29825657848;24335.634965475532;24389.512209755707;24457.755422445905;24569.262922112364;24602.630960535607;9956.203503719686;10108.848367274497;10139.695809125738;10362.792744145076;10376.533056012497;9430.10414010668;9444.669436569824;9508.809823803485;9544.093311135432;9616.134547890724;9276.536173191313;9513.191378732747;9587.328886977984;9642.42145471274;9672.22622190223;2761.130243973142;2783.868148333125;2789.4002789400374;2810.690824009357;2881.7406433420674;943.96696115637;973.1144658360857;973.1193270090579;983.4590974963742;983.488585935324;19797.109130089182;20106.899465502873;20264.392068237976;20424.183032678822;20558.074886630136;1043.984340234897;1049.103016920522;1050.9001644843727;1056.841473778924;1058.867641544807;10956.397398143179;11072.335659860435;11143.387113708663;11245.93163649452;11399.772004560029;455982;459095;463989;477253.6137319361;479627;107370;109147.45426272818;109310;111456.44271778589;112766;1148.5635458525708;1158.6408213453687;1185.5791194125961;1186.5372504723166;1188.970275743096;17745.556361091076;17769.911150444164;18040.458786236435;18085.909570452062;18178.09109544491;56689.716551416976;57263.71368143133;57560.71219643875;58668.11997819951;58741;69400.65299673671;70316;70946;71036.64481677559;71271.64364178145;14638.634034149232;14994.325255363752;15052.172130532927;15094.54716358511;15103.169325687193;22933.197338093087;23104.075836966334;23149.537009260057;23194.072237110326;23348.18281360144;18222.088895554905;18276.360327388476;18339.816601833812;18636.906815465834;18699.158537865558;16141.354345826505;16247.106409147611;16443.177841107656;16491.257893395064;16604.50186494407;18772.906135469235;18777.53056173552;18875.90562047181;18945.43163705091;19060;14138.929305353407;14691.412343506567;14792.186429746036;14820.333085011416;14901.92549037248;18032.90983545074;18358.632827343645;18372.908135459238;18374.173162208;18389.448316550526 15:59:03 INFO - PID 20493 | |3;mootools.html;1348.736996285724;1392.8258967629047;1394.8605139486046;1395.2186775405773;1418.3759145975773;14523.564293071211;15082.245887705625;15132.394704211845;15139.09165450071;15139.091654500724;14761;14882;14897;14933.626659333522;14944.178070206135;2712.850793206368;2845.758110560605;2846.8718907649204;2846.9893187918196;2847.074700722263;2786.6656001279875;2807.101727447218;2876.928076798076;2877.1224776443178;2877.4101309231555;2824.576313552963;2853.186841750102;2853.2581528802557;2854.7430731234185;2855.072101566999;2703.324168957761;2709.5935609658513;2718.415540658758;2723.346396864748;2731.412746259554;2639.261006918066;2652.721464246265;2673.9598906016427;2676.37105280259;2799.8880044798184;14913.105213687213;15028.474003409829;15034.548963531111;15063.322150503254;15071.321790519452;7941.245581669732;8215.548144852031;8247.95876020622;8279.420440569163;8286;5260.947390526122;5382.6232163748555;5474.233607294982;5529.30883639545;5538.944610553883;1963.4993076765477;1965.8230759231737;1980.5840773437596;1989.3932350633052;2007.869488483244;25670.743292567022;25831.35421614456;25832.225033249033;25834.354141146432;25907.48185036289;6749.59502429846;6823.658817059128;6901.930980690229;6921.892497200423;7155.713771449188;17068;17146.657066858843;17148.742768858476;17154.742678859828;17170.656586868194;7902.4863383879865;8118.75643730689;8120.269175774209;8126.837463250702;8190.426670133153;7282.963585182146;7418.221086785918;7547.50941188832;7598.8100297493;7630.198829122974;5058.949410505921;5151.896962060813;5213.556847667991;5216.035033518811;5246.475352464723;1508.585139086738;1514.0764133878545;1531.0507485359149;1537.8692811111182;1559.2203898050975;907.3920473282916;920.6915683246053;927.0266220468482;936.1481052242563;944.4805357053731;7772.7668169954995;7790.987171667647;7862.292393684482;7867.291943725092;7872.252136047066;733.2777214443769;740.4039748002801;742.0649981023948;744.263179452349;750.1823012915838;4591.265397536378;4630.3748993886065;5323;5477.1510415885605;5527.806526771544;19257.903710481358;19900.104495297746;19908.60182796336;19942.60114797696;20177.293794717407;18834.71747923782;19279.132439039997;19639;19795.60408791816;19809.20763169486;10775.515101820436;10809.35143891369;10897.128229741602;10903.073238774792;10915.781684366428;8218.547979861165;8304.003519577689;8330.958345208477;8331.16688331162;8405.201505856934;16946.66106677884;17008.31966721367;17012.829871701124;17192;17302.04838733882;17454.389096381565;17639;17664.116794160498;17758;18043.458696239133;10587.894121058998;10666.8399974002;10670.30643008233;10674.092702120097;10729.302595331279;13092.672683182996;13302.534411295559;13314.46742130304;13315.600531984055;13397.598072057854;10388.11701005423;10428.217883658604;10465.58137674515;10483.580656773644;10650.254482186172;10404.739881503023;10530.842037369599;10545.261831671709;10564.841527376942;10637.14902807758;8928.464292142493;8952.597133128895;9119.407238529475;9212.631494740135;9216.447013179231;7202.53183543068;7286.927130728837;7375.262473752582;7404.814879628052;7429.7399591014055;7436.73971410998;7484.476086673881;7529.435292352986;7531.698732050876;7531.774046778605 15:59:03 INFO - PID 20493 | |4;prototype.html;512.4875124875125;512.6155383462406;529.6345521590102;541.1314839682308;542.3600151820852;6022.969885150574;6262.561620686548;6292.370762923705;6308.936910630892;6322.367763223681;6208.937910620893;6232.937670623292;6279.18370611821;6300.338464461234;6315.168601105674;5201.323827902367;5280.683159010452;5306.575473962083;5314.707691076989;5343.118385466413;5021.874453138665;5144.25408315794;5185.662931909433;5212.1660534314515;5230.529252367286;5278.630495865272;5280.577553795687;5339.172428273624;5347.25138480613;5365.08793505105;5241.3710354757295;5258.13240815265;5299.867503312409;5331.680099194022;5336.4129945705945;4876.341693871317;4900.117978763821;4917.60659147271;4928.186849169919;4929.760406050794;6258.812235632939;6272.6236425814595;6343.746250149989;6351.682415879234;6393.392627700361;6049.466576097804;6095.415192050054;6113.663748493831;6119.66341851198;6171.166892469504;6616.239132499776;6653.168353955755;6718.294579069225;6721.6975236114495;6726.562773419712;5240.8689782755355;5287.550558202557;5325.866853328698;5365.08793505105;5413.404525502192;6967.268436814163;6982.162140543117;7068.646567671647;7099.787006389816;7116.857662846817;5499.642523235977;5527.972360138174;5529.944700553024;5549.556035517149;5614.157876318503;5564;5581.720913954286;5588.944110558842;5595.21666966625;5624.240727501817;6059.394060593993;6068.271807383054;6107.236595425572;6126.203593532812;6129.662868542184;6777.390034896883;6800.931990680129;6803.829904252433;6825.624590647462;6857.319956610662;1820.2355010895456;1830.1855674225108;1842.5854182809028;1899.7625296837896;1915.7260421819335;1390.7566175919173;1444.674948136682;1455.6215384000236;1458.9635259118606;1464.736347457468;5616.803411880564;5640.125780504029;5661.631993920464;5704.372519022904;5708.9714551427805;6543.02292456931;6826.4538836892925;6865.897011544831;6883.346082122191;6924.792256232321;5657.2928383952;5664.405237450091;5677.37548869624;5712.6286791358425;5795.536357091422;3495.702865256431;3499.2651543176216;3512.613612502623;3604.225091605265;3610.29599228148;6377.405648587853;6440.259370172396;6474.255460621995;6507.739690412425;6519.771807986698;6970.337817907291;7017.824554386181;7052.531613935082;7059.364657180879;7069.787906362817;6537.542372034007;6588.769393071219;6700.128983232149;6706.195256569145;6711.295313991961;6835.93164068353;6855.177378714586;6896.551724137915;6914.377706006484;6933.826654333682;6857.417119544894;6863.931360686329;6867.862642747217;6898.517103802686;6901.413379862768;6511.841756747879;6532.020196970492;6595.835104122435;6626.635535045619;6727.629980351127;5052.292679024866;5066.138756411493;5083.212102124176;5084.161113416245;5095.949040509548;6515.250746164252;6709.698063587052;6744.393004629607;6946.9652651736415;7003.509754317352;6310.201592546102;6643.667816609247;6686.632235227109;6712.664366781543;6733.865322693421;6513.413792758674;6554.541182117397;6637.6349300788925;6663.233728121328;6691.498137639794;6303.744972143693;6454.451371633464;6479.157709497735;6503.902441463287;6542.771003014872;6455.225372955276;6530.8367290818105;6563.409293163638;6657.833554161185;6659.602543084389;6358;6453.290138084713;6465.418112369909;6523.575967562093;6575.145231120116 15:59:03 INFO - PID 20493 | |5;yui.html;896.0278098263389;900.2572877376165;913.0914739833867;916.2669864108711;916.6883259691704;18639.534011649717;19440;19447.70828437571;19450.51373715658;19468.9026554867;17586.472405827815;17620.11899405031;17727.113644317764;17739.73390399142;17769.11154442279;934.5374039850267;942.0673533202149;951.1202138022302;953.8616900549416;954.5990683912773;979.2802290316612;987.1017374189489;989.3272574649271;991.3407583956696;991.3655260633201;991.8313886639289;1017.247237044589;1028.1209565821227;1028.5885645741726;1028.5937054863325;1007.0936157458347;1014.0721240065332;1014.3457469931926;1014.5992333028449;1021.6219998600528;726.12501935168;741.3846507398846;747.816784887706;749.1123019222184;749.1123019222239;19238.422847314603;19386.127624256944;19392.12735426909;19459.4162175135;19469.902650486798;21876.89061554698;22056.33830985073;22488.437789055242;22566;22610;17577.560560986076;17722.20250088749;17813.554661133447;17840.375586854527;17905.820941790676;3685.63143685632;3715.6284371562897;3715.64701353371;3718.3492888744363;3719.9070023249365;102717;139630.30184849113;139741.3012934939;145361;146609.99999999892;17757;18152.90923545374;18259.817401826076;18273.451796446127;18287.268509259746;31903.36193276168;32507;32742.50886236708;32793.34413311721;32819;8876.8668469973;8944.463332200088;8972.102789720975;9083.68207112748;9112.362134650512;4142.813573389205;4165.271077561415;4189.790510474464;4215.135897141079;4226.936595951063;5561.805336813192;5637.928793529216;5703.686297253608;5707.801361714087;5726.341470730836;1078.1644225725126;1093.4314156638663;1101.9724506887392;1102.101787043557;1103.475848971732;651.2900937977532;659.4790115808457;674.0394937214547;681.8772620928181;684.4045680258207;11703.882961170279;11813.751218414833;11887.465064072137;12338.259704417764;12673.746525069631;641.9967900160469;653.2618141500075;653.4445721136996;655.9836004099935;664.4485077385855;5979.790707325223;6069.241344831896;6109.389061093855;6122.632642041492;6157.599756015845;120692;123401.38299308626;124994;125369.37315313365;127094.36452817677;109275.45362273138;109929;110710.44644776724;110766;111226;95766;96193;97575.51212243893;99020.51469227967;100193;11079.556817727524;11119.110471162126;11198.888011119785;11284.32294062359;11420.94289528547;44474.77762611166;44819.327710085025;45543.31685024794;45641.31538026999;45715.54284457246;57905.13142302953;59353.70323148529;59567.40432595619;59850;61099;14690.853091468949;14850.034747741362;15028.849711503182;15159.317830697866;15171.544853654408;17832.91083544574;18072.548186294924;18133.365332213838;18197.18112684906;18378.448646540626;14781.408743650563;14865.702685946437;14963.850361496246;15069.47256846005;15083.698326033636;15517.922410387875;15569.68860622804;15629.92185039113;15736.842631573538;15742.055476671436;14392.352344144749;14512.056716313406;14715.705685886436;14828.110313381232;14831.184284864004;10914.563417463212;11072.944635276772;11327.716807079889;11382.886171138183;11470.254433461798;9330.580123894577;9427.717168484956;9607.807843842944;9621.951890240503;9694.85457718149 15:59:03 INFO - PID 20493 | __end_tp_report 15:59:03 INFO - PID 20493 | __start_cc_report 15:59:03 INFO - PID 20493 | _x_x_mozilla_cycle_collect,299 15:59:03 INFO - PID 20493 | __end_cc_report 15:59:03 INFO - PID 20493 | __startTimestamp1506725943636__endTimestamp 15:59:03 INFO - PID 20493 | 15:59:03 INFO - PID 20493 | ------- Summary: start ------- 15:59:03 INFO - PID 20493 | Number of tests: 6 15:59:03 INFO - PID 20493 | 15:59:03 INFO - PID 20493 | [#0] dojo.html Cycles:165 Average:6282.85 Median:6569.15 stddev:900.96 (13.7%) stddev-sans-first:867.79 15:59:03 INFO - PID 20493 | Values: 3071.8 3073.1 3106.4 3142.8 3156.6 6310.9 6341.7 6375.0 6440.8 6480.2 6312.2 6341.3 6354.5 6390.9 6395.4 5861.4 5869.7 5876.0 5883.1 5990.0 5948.2 5969.1 5979.2 5997.2 6031.3 5889.1 5956.5 6013.5 6024.8 6024.8 591.9 5446.9 5828.9 5834.5 5967.5 5852.1 5873.4 5926.7 5930.4 5935.0 6294.7 6396.8 6415.9 6474.7 6489.0 6839.5 6845.7 6856.9 6928.1 6944.7 6914.3 6919.2 6969.6 6989.7 6995.7 6255.3 6263.5 6354.8 6357.3 6360.4 7092.7 7094.4 7102.3 7148.7 7158.5 6743.3 6808.6 6825.9 6826.4 6831.3 6862.7 6889.7 6890.3 6955.4 6982.0 6647.2 6768.3 6784.7 6863.2 6873.6 6876.1 6907.0 6919.7 6947.4 6979.0 5336.4 5341.5 5396.4 5397.0 5431.2 4560.5 4674.5 4710.6 4740.0 4741.8 5816.0 5846.2 5920.9 5922.0 5929.3 6897.6 6914.7 6968.3 6974.1 6998.4 5762.3 5848.2 5850.1 5890.7 5898.3 5832.7 5834.6 5910.7 5922.2 5943.8 6643.9 6658.3 6729.2 6737.4 6761.8 6723.6 6821.9 6826.2 6901.0 6970.2 6556.7 6569.1 6573.9 6596.1 6600.6 6710.8 6794.0 6814.9 6825.1 6843.9 6939.7 6952.2 6978.5 7034.6 7040.6 6626.4 6626.6 6717.0 6719.1 6719.2 6433.0 6551.1 6644.2 6709.4 6730.3 6586.7 6647.5 6700.4 6713.2 6719.4 6740.7 6743.6 6761.1 6798.2 6827.1 6484.6 6510.2 6555.5 6560.3 6592.4 15:59:03 INFO - PID 20493 | 15:59:03 INFO - PID 20493 | [#1] ext.html Cycles:180 Average:37639.72 Median:35856.46 stddev:53167.78 (148.3%) stddev-sans-first:53245.30 15:59:03 INFO - PID 20493 | Values: 884.1 901.2 908.5 909.4 911.6 38835.6 42627.6 42704.1 42783.8 42790.8 39136.6 39259.2 39267.4 39553.0 39564.6 7318.9 7493.5 7495.1 7502.3 7506.4 7224.3 7344.2 7363.6 7367.9 7379.3 7310.7 7313.7 7339.2 7367.5 8049.5 8112.6 8196.9 8198.9 8200.2 8202.1 7867.4 8009.9 8026.8 8103.6 8107.6 38449.2 38889.8 38898.2 38931.2 39020.4 3563.4 3578.6 3607.8 3609.3 3611.0 31201.2 31509.0 31826.5 31958.5 31975.4 5193.5 5212.7 5216.6 5226.9 5253.2 187679.0 188530.0 189323.1 190002.0 190111.0 42621.0 43501.6 48964.5 49126.8 50105.7 52116.4 52432.5 52495.0 52509.0 52530.5 15202.3 15344.1 15651.3 15786.9 15835.6 13219.7 13264.1 13284.1 13310.9 13463.5 14242.5 14366.1 14390.6 14429.5 14655.4 5782.2 5871.7 5904.4 5924.2 6036.2 1011.4 1019.3 1019.8 1027.4 1034.3 22784.0 22806.9 22824.4 23254.1 23752.5 1120.5 1125.3 1128.7 1135.3 1135.9 12255.3 12267.8 12347.3 12367.3 12433.4 229919.0 230862.0 231684.0 231773.0 231901.0 52739.2 52890.0 52912.2 52993.5 53185.2 1383.0 1437.8 1458.5 1459.9 1467.3 23172.5 23283.5 23300.2 23337.3 23892.9 36441.8 36536.0 36583.3 36625.0 36723.8 191767.0 192901.0 193001.0 193233.0 193951.0 33872.7 33915.5 35690.6 35850.6 35862.3 45855.1 45997.8 46058.0 46067.5 46379.3 32949.8 33018.5 33287.0 33330.0 33459.5 32550.8 33126.5 33263.5 33338.8 33651.3 37115.0 37161.8 37407.4 37418.0 37469.8 31938.2 31952.2 32111.2 32261.2 32340.4 23962.9 24200.4 24212.4 24436.9 24785.0 15:59:03 INFO - PID 20493 | 15:59:03 INFO - PID 20493 | [#2] jquery.html Cycles:180 Average:33815.63 Median:23392.09 stddev:78513.04 (335.6%) stddev-sans-first:78693.62 15:59:03 INFO - PID 20493 | Values: 577.3 586.3 593.6 604.5 605.4 22440.4 23383.8 23400.4 23410.3 23413.0 24347.3 24525.9 25887.2 26100.9 26152.9 6545.1 6632.1 6680.0 6699.6 6726.5 6354.7 6538.5 6623.5 6648.9 6660.0 6528.9 6585.4 6586.0 6611.3 6616.5 6327.6 6609.5 6612.3 6616.0 6631.9 6107.6 6117.1 6119.6 6121.1 6153.7 29019.9 29497.4 29522.6 29597.9 29644.7 2040.9 2072.7 2081.0 2090.1 2098.5 19616.0 19782.3 20160.8 20312.8 20350.6 2394.2 2434.7 2437.2 2459.7 2476.2 122843.0 123309.4 128190.0 129704.0 130645.0 14771.2 15082.0 15266.9 15590.3 15594.3 24335.6 24389.5 24457.8 24569.3 24602.6 9956.2 10108.8 10139.7 10362.8 10376.5 9430.1 9444.7 9508.8 9544.1 9616.1 9276.5 9513.2 9587.3 9642.4 9672.2 2761.1 2783.9 2789.4 2810.7 2881.7 944.0 973.1 973.1 983.5 983.5 19797.1 20106.9 20264.4 20424.2 20558.1 1044.0 1049.1 1050.9 1056.8 1058.9 10956.4 11072.3 11143.4 11245.9 11399.8 455982.0 459095.0 463989.0 477253.6 479627.0 107370.0 109147.5 109310.0 111456.4 112766.0 1148.6 1158.6 1185.6 1186.5 1189.0 17745.6 17769.9 18040.5 18085.9 18178.1 56689.7 57263.7 57560.7 58668.1 58741.0 69400.7 70316.0 70946.0 71036.6 71271.6 14638.6 14994.3 15052.2 15094.5 15103.2 22933.2 23104.1 23149.5 23194.1 23348.2 18222.1 18276.4 18339.8 18636.9 18699.2 16141.4 16247.1 16443.2 16491.3 16604.5 18772.9 18777.5 18875.9 18945.4 19060.0 14138.9 14691.4 14792.2 14820.3 14901.9 18032.9 18358.6 18372.9 18374.2 18389.4 15:59:03 INFO - PID 20493 | 15:59:03 INFO - PID 20493 | [#3] mootools.html Cycles:180 Average:9021.97 Median:2711.22 stddev:6256.02 (230.7%) stddev-sans-first:6247.00 15:59:03 INFO - PID 20493 | Values: 1348.7 1392.8 1394.9 1395.2 1418.4 14523.6 15082.2 15132.4 15139.1 15139.1 14761.0 14882.0 14897.0 14933.6 14944.2 2712.9 2845.8 2846.9 2847.0 2847.1 2786.7 2807.1 2876.9 2877.1 2877.4 2824.6 2853.2 2853.3 2854.7 2855.1 2703.3 2709.6 2718.4 2723.3 2731.4 2639.3 2652.7 2674.0 2676.4 2799.9 14913.1 15028.5 15034.5 15063.3 15071.3 7941.2 8215.5 8248.0 8279.4 8286.0 5260.9 5382.6 5474.2 5529.3 5538.9 1963.5 1965.8 1980.6 1989.4 2007.9 25670.7 25831.4 25832.2 25834.4 25907.5 6749.6 6823.7 6901.9 6921.9 7155.7 17068.0 17146.7 17148.7 17154.7 17170.7 7902.5 8118.8 8120.3 8126.8 8190.4 7283.0 7418.2 7547.5 7598.8 7630.2 5058.9 5151.9 5213.6 5216.0 5246.5 1508.6 1514.1 1531.1 1537.9 1559.2 907.4 920.7 927.0 936.1 944.5 7772.8 7791.0 7862.3 7867.3 7872.3 733.3 740.4 742.1 744.3 750.2 4591.3 4630.4 5323.0 5477.2 5527.8 19257.9 19900.1 19908.6 19942.6 20177.3 18834.7 19279.1 19639.0 19795.6 19809.2 10775.5 10809.4 10897.1 10903.1 10915.8 8218.5 8304.0 8331.0 8331.2 8405.2 16946.7 17008.3 17012.8 17192.0 17302.0 17454.4 17639.0 17664.1 17758.0 18043.5 10587.9 10666.8 10670.3 10674.1 10729.3 13092.7 13302.5 13314.5 13315.6 13397.6 10388.1 10428.2 10465.6 10483.6 10650.3 10404.7 10530.8 10545.3 10564.8 10637.1 8928.5 8952.6 9119.4 9212.6 9216.4 7202.5 7286.9 7375.3 7404.8 7429.7 7436.7 7484.5 7529.4 7531.7 7531.8 15:59:03 INFO - PID 20493 | 15:59:03 INFO - PID 20493 | [#4] prototype.html Cycles:180 Average:5685.64 Median:6275.90 stddev:1537.35 (24.5%) stddev-sans-first:1491.82 15:59:03 INFO - PID 20493 | Values: 512.5 512.6 529.6 541.1 542.4 6023.0 6262.6 6292.4 6308.9 6322.4 6208.9 6232.9 6279.2 6300.3 6315.2 5201.3 5280.7 5306.6 5314.7 5343.1 5021.9 5144.3 5185.7 5212.2 5230.5 5278.6 5280.6 5339.2 5347.3 5365.1 5241.4 5258.1 5299.9 5331.7 5336.4 4876.3 4900.1 4917.6 4928.2 4929.8 6258.8 6272.6 6343.7 6351.7 6393.4 6049.5 6095.4 6113.7 6119.7 6171.2 6616.2 6653.2 6718.3 6721.7 6726.6 5240.9 5287.6 5325.9 5365.1 5413.4 6967.3 6982.2 7068.6 7099.8 7116.9 5499.6 5528.0 5529.9 5549.6 5614.2 5564.0 5581.7 5588.9 5595.2 5624.2 6059.4 6068.3 6107.2 6126.2 6129.7 6777.4 6800.9 6803.8 6825.6 6857.3 1820.2 1830.2 1842.6 1899.8 1915.7 1390.8 1444.7 1455.6 1459.0 1464.7 5616.8 5640.1 5661.6 5704.4 5709.0 6543.0 6826.5 6865.9 6883.3 6924.8 5657.3 5664.4 5677.4 5712.6 5795.5 3495.7 3499.3 3512.6 3604.2 3610.3 6377.4 6440.3 6474.3 6507.7 6519.8 6970.3 7017.8 7052.5 7059.4 7069.8 6537.5 6588.8 6700.1 6706.2 6711.3 6835.9 6855.2 6896.6 6914.4 6933.8 6857.4 6863.9 6867.9 6898.5 6901.4 6511.8 6532.0 6595.8 6626.6 6727.6 5052.3 5066.1 5083.2 5084.2 5095.9 6515.3 6709.7 6744.4 6947.0 7003.5 6310.2 6643.7 6686.6 6712.7 6733.9 6513.4 6554.5 6637.6 6663.2 6691.5 6303.7 6454.5 6479.2 6503.9 6542.8 6455.2 6530.8 6563.4 6657.8 6659.6 6358.0 6453.3 6465.4 6523.6 6575.1 15:59:03 INFO - PID 20493 | 15:59:03 INFO - PID 20493 | [#5] yui.html Cycles:180 Average:24397.81 Median:19449.11 stddev:35447.54 (182.3%) stddev-sans-first:35503.06 15:59:03 INFO - PID 20493 | Values: 896.0 900.3 913.1 916.3 916.7 18639.5 19440.0 19447.7 19450.5 19468.9 17586.5 17620.1 17727.1 17739.7 17769.1 934.5 942.1 951.1 953.9 954.6 979.3 987.1 989.3 991.3 991.4 991.8 1017.2 1028.1 1028.6 1028.6 1007.1 1014.1 1014.3 1014.6 1021.6 726.1 741.4 747.8 749.1 749.1 19238.4 19386.1 19392.1 19459.4 19469.9 21876.9 22056.3 22488.4 22566.0 22610.0 17577.6 17722.2 17813.6 17840.4 17905.8 3685.6 3715.6 3715.6 3718.3 3719.9 102717.0 139630.3 139741.3 145361.0 146610.0 17757.0 18152.9 18259.8 18273.5 18287.3 31903.4 32507.0 32742.5 32793.3 32819.0 8876.9 8944.5 8972.1 9083.7 9112.4 4142.8 4165.3 4189.8 4215.1 4226.9 5561.8 5637.9 5703.7 5707.8 5726.3 1078.2 1093.4 1102.0 1102.1 1103.5 651.3 659.5 674.0 681.9 684.4 11703.9 11813.8 11887.5 12338.3 12673.7 642.0 653.3 653.4 656.0 664.4 5979.8 6069.2 6109.4 6122.6 6157.6 120692.0 123401.4 124994.0 125369.4 127094.4 109275.5 109929.0 110710.4 110766.0 111226.0 95766.0 96193.0 97575.5 99020.5 100193.0 11079.6 11119.1 11198.9 11284.3 11420.9 44474.8 44819.3 45543.3 45641.3 45715.5 57905.1 59353.7 59567.4 59850.0 61099.0 14690.9 14850.0 15028.8 15159.3 15171.5 17832.9 18072.5 18133.4 18197.2 18378.4 14781.4 14865.7 14963.9 15069.5 15083.7 15517.9 15569.7 15629.9 15736.8 15742.1 14392.4 14512.1 14715.7 14828.1 14831.2 10914.6 11072.9 11327.7 11382.9 11470.3 9330.6 9427.7 9607.8 9622.0 9694.9 15:59:03 INFO - PID 20493 | -------- Summary: end -------- 15:59:03 INFO - PID 20493 | 15:59:04 INFO - TEST-INFO | 20493: exit 0 15:59:04 INFO - TEST-OK | dromaeo_css | took 1107869ms 15:59:04 INFO - TEST-START | kraken 15:59:04 INFO - Initialising browser for kraken test... 15:59:04 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35201/getInfo.html -profile /tmp/tmpMRFdaV/profile 15:59:04 INFO - TEST-INFO | started process 20853 (/builds/slave/test/build/application/firefox/firefox http://localhost:35201/getInfo.html) 15:59:09 INFO - TEST-INFO | 20853: exit 0 15:59:09 INFO - Browser initialized. 15:59:09 INFO - Running cycle 1/1 for kraken test... 15:59:09 INFO - Using env: {'DISPLAY': ':0', 15:59:09 INFO - 'HOME': '/home/cltbld', 15:59:09 INFO - 'JSGC_DISABLE_POISONING': '1', 15:59:09 INFO - 'LANG': 'en_US.UTF-8', 15:59:09 INFO - 'LANGUAGE': 'en_US:en', 15:59:09 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:59:09 INFO - 'LOGNAME': 'cltbld', 15:59:09 INFO - 'MAIL': '/var/mail/cltbld', 15:59:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:59:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:59:09 INFO - 'MOZ_CRASHREPORTER': '1', 15:59:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:09 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:59:09 INFO - 'MOZ_NO_REMOTE': '1', 15:59:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:59:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:09 INFO - 'NO_EM_RESTART': '1', 15:59:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:09 INFO - 'PWD': '/builds/slave/test', 15:59:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:59:09 INFO - 'RUST_BACKTRACE': 'full', 15:59:09 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:59:09 INFO - 'SHELL': '/bin/bash', 15:59:09 INFO - 'SHLVL': '1', 15:59:09 INFO - 'STYLO_FORCE_DISABLED': '1', 15:59:09 INFO - 'TERM': 'linux', 15:59:09 INFO - 'TMOUT': '86400', 15:59:09 INFO - 'USER': 'cltbld', 15:59:09 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506721513.636646-961579602', 15:59:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:09 INFO - '_': '/tools/buildbot/bin/python'} 15:59:09 INFO - TEST-INFO | started process 21085 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMRFdaV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:59:10 INFO - PID 21085 | 15:59:10 INFO - PID 21085 | (/builds/slave/test/build/application/firefox/firefox:21134): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:59:10 INFO - PID 21085 | 15:59:20 INFO - PID 21085 | RSS: Main: 154189824 15:59:20 INFO - PID 21085 | 15:59:23 INFO - PID 21085 | Cycle 1(1): loaded http://localhost:35201/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35201/tests/kraken/driver.html?testName=audio-beat-detection) 15:59:23 INFO - PID 21085 | RSS: Main: 160956416 15:59:23 INFO - PID 21085 | 15:59:26 INFO - PID 21085 | Cycle 1(1): loaded http://localhost:35201/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35201/tests/kraken/driver.html?testName=audio-dft) 15:59:27 INFO - PID 21085 | RSS: Main: 161013760 15:59:27 INFO - PID 21085 | 15:59:30 INFO - PID 21085 | Cycle 1(1): loaded http://localhost:35201/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35201/tests/kraken/driver.html?testName=audio-fft) 15:59:30 INFO - PID 21085 | RSS: Main: 156418048 15:59:30 INFO - PID 21085 | 15:59:32 INFO - PID 21085 | Cycle 1(1): loaded http://localhost:35201/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35201/tests/kraken/driver.html?testName=audio-oscillator) 15:59:33 INFO - PID 21085 | RSS: Main: 156741632 15:59:33 INFO - PID 21085 | 15:59:35 INFO - PID 21085 | Cycle 1(1): loaded http://localhost:35201/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35201/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:59:36 INFO - PID 21085 | RSS: Main: 156573696 15:59:36 INFO - PID 21085 | 15:59:39 INFO - PID 21085 | Cycle 1(1): loaded http://localhost:35201/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35201/tests/kraken/driver.html?testName=imaging-darkroom) 15:59:40 INFO - PID 21085 | RSS: Main: 159764480 15:59:40 INFO - PID 21085 | 15:59:43 INFO - PID 21085 | Cycle 1(1): loaded http://localhost:35201/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35201/tests/kraken/driver.html?testName=imaging-desaturate) 15:59:44 INFO - PID 21085 | RSS: Main: 159997952 15:59:44 INFO - PID 21085 | 15:59:47 INFO - PID 21085 | Cycle 1(1): loaded http://localhost:35201/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35201/tests/kraken/driver.html?testName=json-parse-financial) 15:59:47 INFO - PID 21085 | RSS: Main: 159920128 15:59:47 INFO - PID 21085 | 15:59:49 INFO - PID 21085 | Cycle 1(1): loaded http://localhost:35201/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35201/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:59:50 INFO - PID 21085 | RSS: Main: 159997952 15:59:50 INFO - PID 21085 | 15:59:51 INFO - PID 21085 | Cycle 1(1): loaded http://localhost:35201/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35201/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:59:52 INFO - PID 21085 | RSS: Main: 159850496 15:59:52 INFO - PID 21085 | 15:59:54 INFO - PID 21085 | Cycle 1(1): loaded http://localhost:35201/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35201/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:59:55 INFO - PID 21085 | RSS: Main: 156717056 15:59:55 INFO - PID 21085 | 15:59:57 INFO - PID 21085 | Cycle 1(1): loaded http://localhost:35201/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35201/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:59:58 INFO - PID 21085 | RSS: Main: 156999680 15:59:58 INFO - PID 21085 | 16:00:01 INFO - PID 21085 | Cycle 1(1): loaded http://localhost:35201/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35201/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:00:01 INFO - PID 21085 | RSS: Main: 157282304 16:00:01 INFO - PID 21085 | 16:00:03 INFO - PID 21085 | Cycle 1(1): loaded http://localhost:35201/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35201/tests/kraken/driver.html?testName=ai-astar) 16:00:03 INFO - PID 21085 | RSS: Main: 158646272 16:00:03 INFO - PID 21085 | 16:00:03 INFO - PID 21085 | __start_tp_report 16:00:03 INFO - PID 21085 | _x_x_mozilla_page_load 16:00:03 INFO - PID 21085 | _x_x_mozilla_page_load_details 16:00:03 INFO - PID 21085 | |i|pagename|runs| 16:00:03 INFO - PID 21085 | |0;ai-astar;109;109;106;108;110;107;108;108;109;107 16:00:03 INFO - PID 21085 | |1;audio-beat-detection;117;118;116;115;129;121;118;117;117;119 16:00:03 INFO - PID 21085 | |2;audio-dft;163;163;162;163;164;164;163;164;173;166 16:00:03 INFO - PID 21085 | |3;audio-fft;74;73;73;73;74;74;74;74;76;74 16:00:03 INFO - PID 21085 | |4;audio-oscillator;81;79;79;78;77;79;80;80;80;78 16:00:03 INFO - PID 21085 | |5;imaging-gaussian-blur;116;113;114;116;114;113;111;112;112;111 16:00:03 INFO - PID 21085 | |6;imaging-darkroom;148;147;147;148;150;151;150;148;149;148 16:00:03 INFO - PID 21085 | |7;imaging-desaturate;97;94;95;94;94;94;95;99;99;94 16:00:03 INFO - PID 21085 | |8;json-parse-financial;52;54;51;55;53;51;53;53;52;51 16:00:03 INFO - PID 21085 | |9;json-stringify-tinderbox;37;38;37;37;37;37;38;37;37;38 16:00:03 INFO - PID 21085 | |10;stanford-crypto-aes;79;72;73;78;74;74;72;76;76;74 16:00:03 INFO - PID 21085 | |11;stanford-crypto-ccm;112;114;109;116;109;117;123;112;109;119 16:00:03 INFO - PID 21085 | |12;stanford-crypto-pbkdf2;170;167;156;160;162;168;165;162;161;159 16:00:03 INFO - PID 21085 | |13;stanford-crypto-sha256-iterative;64;64;63;64;61;64;70;68;64;70 16:00:03 INFO - PID 21085 | __end_tp_report 16:00:03 INFO - PID 21085 | __start_cc_report 16:00:03 INFO - PID 21085 | _x_x_mozilla_cycle_collect,753 16:00:03 INFO - PID 21085 | __end_cc_report 16:00:03 INFO - PID 21085 | __startTimestamp1506726003739__endTimestamp 16:00:03 INFO - PID 21085 | 16:00:03 INFO - PID 21085 | ------- Summary: start ------- 16:00:03 INFO - PID 21085 | Number of tests: 14 16:00:03 INFO - PID 21085 | 16:00:03 INFO - PID 21085 | [#0] ai-astar Cycles:10 Average:108.10 Median:108.50 stddev:1.20 (1.1%) stddev-sans-first:1.22 16:00:03 INFO - PID 21085 | Values: 109.0 109.0 106.0 108.0 110.0 107.0 108.0 108.0 109.0 107.0 16:00:03 INFO - PID 21085 | 16:00:03 INFO - PID 21085 | [#1] audio-beat-detection Cycles:10 Average:118.70 Median:118.00 stddev:3.97 (3.4%) stddev-sans-first:4.17 16:00:03 INFO - PID 21085 | Values: 117.0 118.0 116.0 115.0 129.0 121.0 118.0 117.0 117.0 119.0 16:00:03 INFO - PID 21085 | 16:00:03 INFO - PID 21085 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.00 stddev:3.17 (1.9%) stddev-sans-first:3.32 16:00:03 INFO - PID 21085 | Values: 163.0 163.0 162.0 163.0 164.0 164.0 163.0 164.0 173.0 166.0 16:00:03 INFO - PID 21085 | 16:00:03 INFO - PID 21085 | [#3] audio-fft Cycles:10 Average:73.90 Median:74.00 stddev:0.88 (1.2%) stddev-sans-first:0.93 16:00:03 INFO - PID 21085 | Values: 74.0 73.0 73.0 73.0 74.0 74.0 74.0 74.0 76.0 74.0 16:00:03 INFO - PID 21085 | 16:00:03 INFO - PID 21085 | [#4] audio-oscillator Cycles:10 Average:79.10 Median:79.50 stddev:1.20 (1.5%) stddev-sans-first:1.05 16:00:03 INFO - PID 21085 | Values: 81.0 79.0 79.0 78.0 77.0 79.0 80.0 80.0 80.0 78.0 16:00:03 INFO - PID 21085 | 16:00:03 INFO - PID 21085 | [#5] imaging-gaussian-blur Cycles:10 Average:113.20 Median:113.50 stddev:1.81 (1.6%) stddev-sans-first:1.62 16:00:03 INFO - PID 21085 | Values: 116.0 113.0 114.0 116.0 114.0 113.0 111.0 112.0 112.0 111.0 16:00:03 INFO - PID 21085 | 16:00:03 INFO - PID 21085 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:148.50 stddev:1.35 (0.9%) stddev-sans-first:1.41 16:00:03 INFO - PID 21085 | Values: 148.0 147.0 147.0 148.0 150.0 151.0 150.0 148.0 149.0 148.0 16:00:03 INFO - PID 21085 | 16:00:03 INFO - PID 21085 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.00 stddev:2.07 (2.2%) stddev-sans-first:2.12 16:00:03 INFO - PID 21085 | Values: 97.0 94.0 95.0 94.0 94.0 94.0 95.0 99.0 99.0 94.0 16:00:03 INFO - PID 21085 | 16:00:03 INFO - PID 21085 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:53.00 stddev:1.35 (2.6%) stddev-sans-first:1.42 16:00:03 INFO - PID 21085 | Values: 52.0 54.0 51.0 55.0 53.0 51.0 53.0 53.0 52.0 51.0 16:00:03 INFO - PID 21085 | 16:00:03 INFO - PID 21085 | [#9] json-stringify-tinderbox Cycles:10 Average:37.30 Median:37.00 stddev:0.48 (1.3%) stddev-sans-first:0.50 16:00:03 INFO - PID 21085 | Values: 37.0 38.0 37.0 37.0 37.0 37.0 38.0 37.0 37.0 38.0 16:00:03 INFO - PID 21085 | 16:00:03 INFO - PID 21085 | [#10] stanford-crypto-aes Cycles:10 Average:74.80 Median:75.00 stddev:2.39 (3.2%) stddev-sans-first:2.00 16:00:03 INFO - PID 21085 | Values: 79.0 72.0 73.0 78.0 74.0 74.0 72.0 76.0 76.0 74.0 16:00:03 INFO - PID 21085 | 16:00:03 INFO - PID 21085 | [#11] stanford-crypto-ccm Cycles:10 Average:114.00 Median:115.00 stddev:4.74 (4.1%) stddev-sans-first:4.97 16:00:03 INFO - PID 21085 | Values: 112.0 114.0 109.0 116.0 109.0 117.0 123.0 112.0 109.0 119.0 16:00:03 INFO - PID 21085 | 16:00:03 INFO - PID 21085 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.00 Median:163.50 stddev:4.40 (2.7%) stddev-sans-first:3.87 16:00:03 INFO - PID 21085 | Values: 170.0 167.0 156.0 160.0 162.0 168.0 165.0 162.0 161.0 159.0 16:00:03 INFO - PID 21085 | 16:00:03 INFO - PID 21085 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:64.00 stddev:3.05 (4.8%) stddev-sans-first:3.20 16:00:03 INFO - PID 21085 | Values: 64.0 64.0 63.0 64.0 61.0 64.0 70.0 68.0 64.0 70.0 16:00:03 INFO - PID 21085 | -------- Summary: end -------- 16:00:03 INFO - PID 21085 | 16:00:04 INFO - PID 21085 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:00:04 INFO - TEST-INFO | 21085: exit 0 16:00:04 INFO - TEST-OK | kraken | took 60260ms 16:00:04 INFO - SUITE-END | took 1168s 16:00:04 INFO - Completed test suite (00:19:28) 16:00:04 INFO - javascript benchmark 16:00:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8568.352346113263, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3071.815691058538, 3073.10879844845, 3106.3631955449137, 3142.764292678049, 3156.621205455345, 6310.936890631092, 6341.6829158542005, 6375.043743438487, 6440.806775796727, 6480.189976252975, 6312.210973628296, 6341.3341599132, 6354.459870910967, 6390.936090639092, 6395.360463953602, 5861.413858614126, 5869.706514674271, 5876.030454974924, 5883.117532370136, 5990.0, 5948.167256584082, 5969.074793407029, 5979.222701048858, 5997.190379298804, 6031.276246850384, 5889.116632505115, 5956.52347812174, 6013.51891848651, 6024.759009639609, 6024.849378765544, 591.927841177457, 5446.8910621787345, 5828.854278643025, 5834.504067154255, 5967.4629283364275, 5852.092925596539, 5873.442023007808, 5926.733297001645, 5930.3773103823905, 5934.97032514839, 6294.685265736741, 6396.840078998062, 6415.903761443582, 6474.74101035958, 6489.0, 6839.452843772487, 6845.657717114174, 6856.862862742767, 6928.099347084847, 6944.72221111155, 6914.308569143096, 6919.204291506491, 6969.6166710830885, 6989.685464154125, 6995.685194166274, 6255.280642726099, 6263.4989200864275, 6354.777582784581, 6357.268914074848, 6360.395762402518, 7092.716291348288, 7094.361507464353, 7102.325279098581, 7148.678309476086, 7158.534695244793, 6743.2919543448215, 6808.557443766238, 6825.931740682529, 6826.385625293748, 6831.28271531492, 6862.656867156622, 6889.724411023503, 6890.345417185359, 6955.408790252784, 6981.965090174516, 6647.235567909753, 6768.289329620417, 6784.728610855511, 6863.210730766026, 6873.553219040847, 6876.140482439695, 6906.965465172742, 6919.654017299215, 6947.444204463631, 6978.965105174543, 5336.359636843604, 5341.5192632662465, 5396.379416367168, 5396.9730151348995, 5431.158170483582, 4560.452745670541, 4674.5325467452985, 4710.576048155683, 4739.957209413923, 4741.83403580873, 5816.0, 5846.181534585162, 5920.911186332209, 5921.970390148022, 5929.3181284152015, 6897.620630865351, 6914.688839002257, 6968.338007889242, 6974.093367862247, 6998.440124790005, 5762.30852297727, 5848.239728835224, 5850.12248162779, 5890.705464726832, 5898.262717160355, 5832.708364581754, 5834.620749651259, 5910.674912879833, 5922.200502932135, 5943.791967281124, 6643.900341494881, 6658.300878407795, 6729.158855143107, 6737.393634572814, 6761.763338283136, 6723.596584204964, 6821.89767153503, 6826.180858297036, 6901.0, 6970.233274339818, 6556.704948277435, 6569.146011018537, 6573.934260657332, 6596.142501474777, 6600.570962887397, 6710.798676039727, 6793.966030169818, 6814.897776533455, 6825.112735344572, 6843.931560684329, 6939.653017349214, 6952.165740111219, 6978.476614254053, 7034.577925324497, 7040.57756534589, 6626.403623673892, 6626.602403855784, 6717.0, 6719.059331693469, 6719.227288861648, 6433.0, 6551.148350714377, 6644.169478815148, 6709.36261055199, 6730.259671436236, 6586.736530538725, 6647.4682025438815, 6700.363465470772, 6713.160854893138, 6719.428848547928, 6740.6966686498245, 6743.561668491532, 6761.053452516553, 6798.218204906301, 6827.146606674166, 6484.610923344614, 6510.18622672166, 6555.508336874658, 6560.3111673275525, 6592.43964263043], "value": 6214.201086926476, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [884.1158841158841, 901.179926267097, 908.500324821348, 909.4406939732063, 911.6353458616557, 38835.61164388359, 42627.57372426275, 42704.14591708164, 42783.78608106959, 42790.78604606973, 39136.60863391365, 39259.21481570367, 39267.41098883519, 39553.01117472065, 39564.60435395645, 7318.8902166467415, 7493.475456718032, 7495.138059123189, 7502.32479076883, 7506.361959233472, 7224.3136901994485, 7344.192138864747, 7363.631818409085, 7367.926320736778, 7379.335859772619, 7310.671019804122, 7313.7074517019255, 7339.155997060353, 7367.484276100675, 8049.47678400905, 8112.553809540473, 8196.918030819736, 8198.877016844752, 8200.220979007014, 8202.097769245378, 7867.370610351159, 8009.9199008009755, 8026.799330016738, 8103.554304513249, 8107.594620268963, 38449.23101537982, 38889.805550972065, 38898.22203555941, 38931.22137557233, 39020.41469377962, 3563.3585954528176, 3578.5526809148855, 3607.7654952428006, 3609.2781443711365, 3610.963890361089, 31201.21996950072, 31509.0, 31826.522602160985, 31958.520622190685, 31975.360492790012, 5193.454687257821, 5212.713300768456, 5216.608754343401, 5226.895462090775, 5253.185756207756, 187679.0, 188530.0, 189323.05338473356, 190002.0, 190111.04944475327, 42621.0, 43501.564984350385, 48964.51035489671, 49126.754366228655, 50105.74947125314, 52116.436506904094, 52432.47567524276, 52495.0, 52509.0, 52530.474695253324, 15202.315895784715, 15344.079355238722, 15651.295691693673, 15786.921065394828, 15835.604109897115, 13219.66950826237, 13264.071514994052, 13284.136531125447, 13310.866891331156, 13463.461461541625, 14242.504537023671, 14366.066205696596, 14390.568282951528, 14429.494967676292, 14655.413783448756, 5782.248307720053, 5871.706414679249, 5904.380040095814, 5924.200232968494, 6036.245469316335, 1011.3881101933224, 1019.3374306700704, 1019.8164330420595, 1027.3630349183404, 1034.255336157965, 22784.0, 22806.885965570065, 22824.429389265402, 23254.06983720666, 23752.524949500912, 1120.4621781544904, 1125.3472985668293, 1128.7403897103711, 1135.3415019288793, 1135.9318440893574, 12255.264684118982, 12267.815982760265, 12347.320897350732, 12367.257964522158, 12433.37833108341, 229919.0, 230862.0, 231684.0, 231773.0, 231901.0, 52739.20891186635, 52890.0, 52912.20631690528, 52993.470065299625, 53185.2022219667, 1382.9654258643614, 1437.805896203999, 1458.5259790568107, 1459.9343029563695, 1467.3030310602378, 23172.53654926858, 23283.534329313658, 23300.184493542645, 23337.299881003597, 23892.88053559721, 36441.81779091193, 36536.0, 36583.26833463369, 36625.0, 36723.816380917924, 191767.0, 192901.0, 193001.0, 193233.0, 193951.0, 33872.66127338695, 33915.49126763051, 35690.64309356977, 35850.64149358473, 35862.28275434529, 45855.082898342516, 45997.77001114973, 46058.0, 46067.539324606325, 46379.30431043605, 32949.83525082359, 33018.504722429665, 33287.0, 33330.00019998711, 33459.49810752792, 32550.837245814568, 33126.503102453964, 33263.50104748479, 33338.833305833316, 33651.3269734599, 37115.0, 37161.814190928875, 37407.43888841615, 37418.0, 37469.81265093657, 31938.19958380541, 31952.201194970312, 32111.197220069684, 32261.193470163435, 32340.35319293648, 23962.88018559896, 24200.394990125387, 24212.39469013289, 24436.87781561081, 24785.0], "value": 17308.412309761014, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.3331801768958, 586.2964442668793, 593.6075329491953, 604.5435696049483, 605.4187979539643, 22440.43898902526, 23383.766162338372, 23400.414989625267, 23410.297691069274, 23413.0, 24347.26958191257, 24525.877370613165, 25887.22338329853, 26100.869495652543, 26152.86923565384, 6545.149130613026, 6632.137822083122, 6680.0, 6699.564528305645, 6726.529142959995, 6354.650494222816, 6538.542302038859, 6623.503237257225, 6648.900266496006, 6660.034295027218, 6528.934710652904, 6585.440237579812, 6586.0, 6611.338866113374, 6616.470682345401, 6327.588706734071, 6609.504287178481, 6612.338766123373, 6616.0406741022525, 6631.93368066318, 6107.572469927107, 6117.051856962178, 6119.602225855305, 6121.051237058263, 6153.661548614825, 29019.85490072557, 29497.41005179906, 29522.55716164259, 29597.852010740025, 29644.70355296441, 2040.8571400002006, 2072.7409073865765, 2080.9895950520304, 2090.1221486975355, 2098.548812005411, 19616.0, 19782.30761923326, 20160.79839201604, 20312.79687203124, 20350.592988140153, 2394.199467298024, 2434.720007199177, 2437.195725410628, 2459.6802415685847, 2476.1828596563273, 122843.0, 123309.38345308306, 128190.0, 129704.0, 130645.0, 14771.187584682946, 15082.0, 15266.923665381602, 15590.298436570381, 15594.29825657848, 24335.634965475532, 24389.512209755707, 24457.755422445905, 24569.262922112364, 24602.630960535607, 9956.203503719686, 10108.848367274497, 10139.695809125738, 10362.792744145076, 10376.533056012497, 9430.10414010668, 9444.669436569824, 9508.809823803485, 9544.093311135432, 9616.134547890724, 9276.536173191313, 9513.191378732747, 9587.328886977984, 9642.42145471274, 9672.22622190223, 2761.130243973142, 2783.868148333125, 2789.4002789400374, 2810.690824009357, 2881.7406433420674, 943.96696115637, 973.1144658360857, 973.1193270090579, 983.4590974963742, 983.488585935324, 19797.109130089182, 20106.899465502873, 20264.392068237976, 20424.183032678822, 20558.074886630136, 1043.984340234897, 1049.103016920522, 1050.9001644843727, 1056.841473778924, 1058.867641544807, 10956.397398143179, 11072.335659860435, 11143.387113708663, 11245.93163649452, 11399.772004560029, 455982.0, 459095.0, 463989.0, 477253.6137319361, 479627.0, 107370.0, 109147.45426272818, 109310.0, 111456.44271778589, 112766.0, 1148.5635458525708, 1158.6408213453687, 1185.5791194125961, 1186.5372504723166, 1188.970275743096, 17745.556361091076, 17769.911150444164, 18040.458786236435, 18085.909570452062, 18178.09109544491, 56689.716551416976, 57263.71368143133, 57560.71219643875, 58668.11997819951, 58741.0, 69400.65299673671, 70316.0, 70946.0, 71036.64481677559, 71271.64364178145, 14638.634034149232, 14994.325255363752, 15052.172130532927, 15094.54716358511, 15103.169325687193, 22933.197338093087, 23104.075836966334, 23149.537009260057, 23194.072237110326, 23348.18281360144, 18222.088895554905, 18276.360327388476, 18339.816601833812, 18636.906815465834, 18699.158537865558, 16141.354345826505, 16247.106409147611, 16443.177841107656, 16491.257893395064, 16604.50186494407, 18772.906135469235, 18777.53056173552, 18875.90562047181, 18945.43163705091, 19060.0, 14138.929305353407, 14691.412343506567, 14792.186429746036, 14820.333085011416, 14901.92549037248, 18032.90983545074, 18358.632827343645, 18372.908135459238, 18374.173162208, 18389.448316550526], "value": 12044.418844485535, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1348.736996285724, 1392.8258967629047, 1394.8605139486046, 1395.2186775405773, 1418.3759145975773, 14523.564293071211, 15082.245887705625, 15132.394704211845, 15139.09165450071, 15139.091654500724, 14761.0, 14882.0, 14897.0, 14933.626659333522, 14944.178070206135, 2712.850793206368, 2845.758110560605, 2846.8718907649204, 2846.9893187918196, 2847.074700722263, 2786.6656001279875, 2807.101727447218, 2876.928076798076, 2877.1224776443178, 2877.4101309231555, 2824.576313552963, 2853.186841750102, 2853.2581528802557, 2854.7430731234185, 2855.072101566999, 2703.324168957761, 2709.5935609658513, 2718.415540658758, 2723.346396864748, 2731.412746259554, 2639.261006918066, 2652.721464246265, 2673.9598906016427, 2676.37105280259, 2799.8880044798184, 14913.105213687213, 15028.474003409829, 15034.548963531111, 15063.322150503254, 15071.321790519452, 7941.245581669732, 8215.548144852031, 8247.95876020622, 8279.420440569163, 8286.0, 5260.947390526122, 5382.6232163748555, 5474.233607294982, 5529.30883639545, 5538.944610553883, 1963.4993076765477, 1965.8230759231737, 1980.5840773437596, 1989.3932350633052, 2007.869488483244, 25670.743292567022, 25831.35421614456, 25832.225033249033, 25834.354141146432, 25907.48185036289, 6749.59502429846, 6823.658817059128, 6901.930980690229, 6921.892497200423, 7155.713771449188, 17068.0, 17146.657066858843, 17148.742768858476, 17154.742678859828, 17170.656586868194, 7902.4863383879865, 8118.75643730689, 8120.269175774209, 8126.837463250702, 8190.426670133153, 7282.963585182146, 7418.221086785918, 7547.50941188832, 7598.8100297493, 7630.198829122974, 5058.949410505921, 5151.896962060813, 5213.556847667991, 5216.035033518811, 5246.475352464723, 1508.585139086738, 1514.0764133878545, 1531.0507485359149, 1537.8692811111182, 1559.2203898050975, 907.3920473282916, 920.6915683246053, 927.0266220468482, 936.1481052242563, 944.4805357053731, 7772.7668169954995, 7790.987171667647, 7862.292393684482, 7867.291943725092, 7872.252136047066, 733.2777214443769, 740.4039748002801, 742.0649981023948, 744.263179452349, 750.1823012915838, 4591.265397536378, 4630.3748993886065, 5323.0, 5477.1510415885605, 5527.806526771544, 19257.903710481358, 19900.104495297746, 19908.60182796336, 19942.60114797696, 20177.293794717407, 18834.71747923782, 19279.132439039997, 19639.0, 19795.60408791816, 19809.20763169486, 10775.515101820436, 10809.35143891369, 10897.128229741602, 10903.073238774792, 10915.781684366428, 8218.547979861165, 8304.003519577689, 8330.958345208477, 8331.16688331162, 8405.201505856934, 16946.66106677884, 17008.31966721367, 17012.829871701124, 17192.0, 17302.04838733882, 17454.389096381565, 17639.0, 17664.116794160498, 17758.0, 18043.458696239133, 10587.894121058998, 10666.8399974002, 10670.30643008233, 10674.092702120097, 10729.302595331279, 13092.672683182996, 13302.534411295559, 13314.46742130304, 13315.600531984055, 13397.598072057854, 10388.11701005423, 10428.217883658604, 10465.58137674515, 10483.580656773644, 10650.254482186172, 10404.739881503023, 10530.842037369599, 10545.261831671709, 10564.841527376942, 10637.14902807758, 8928.464292142493, 8952.597133128895, 9119.407238529475, 9212.631494740135, 9216.447013179231, 7202.53183543068, 7286.927130728837, 7375.262473752582, 7404.814879628052, 7429.7399591014055, 7436.73971410998, 7484.476086673881, 7529.435292352986, 7531.698732050876, 7531.774046778605], "value": 6540.923386449282, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [512.4875124875125, 512.6155383462406, 529.6345521590102, 541.1314839682308, 542.3600151820852, 6022.969885150574, 6262.561620686548, 6292.370762923705, 6308.936910630892, 6322.367763223681, 6208.937910620893, 6232.937670623292, 6279.18370611821, 6300.338464461234, 6315.168601105674, 5201.323827902367, 5280.683159010452, 5306.575473962083, 5314.707691076989, 5343.118385466413, 5021.874453138665, 5144.25408315794, 5185.662931909433, 5212.1660534314515, 5230.529252367286, 5278.630495865272, 5280.577553795687, 5339.172428273624, 5347.25138480613, 5365.08793505105, 5241.3710354757295, 5258.13240815265, 5299.867503312409, 5331.680099194022, 5336.4129945705945, 4876.341693871317, 4900.117978763821, 4917.60659147271, 4928.186849169919, 4929.760406050794, 6258.812235632939, 6272.6236425814595, 6343.746250149989, 6351.682415879234, 6393.392627700361, 6049.466576097804, 6095.415192050054, 6113.663748493831, 6119.66341851198, 6171.166892469504, 6616.239132499776, 6653.168353955755, 6718.294579069225, 6721.6975236114495, 6726.562773419712, 5240.8689782755355, 5287.550558202557, 5325.866853328698, 5365.08793505105, 5413.404525502192, 6967.268436814163, 6982.162140543117, 7068.646567671647, 7099.787006389816, 7116.857662846817, 5499.642523235977, 5527.972360138174, 5529.944700553024, 5549.556035517149, 5614.157876318503, 5564.0, 5581.720913954286, 5588.944110558842, 5595.21666966625, 5624.240727501817, 6059.394060593993, 6068.271807383054, 6107.236595425572, 6126.203593532812, 6129.662868542184, 6777.390034896883, 6800.931990680129, 6803.829904252433, 6825.624590647462, 6857.319956610662, 1820.2355010895456, 1830.1855674225108, 1842.5854182809028, 1899.7625296837896, 1915.7260421819335, 1390.7566175919173, 1444.674948136682, 1455.6215384000236, 1458.9635259118606, 1464.736347457468, 5616.803411880564, 5640.125780504029, 5661.631993920464, 5704.372519022904, 5708.9714551427805, 6543.02292456931, 6826.4538836892925, 6865.897011544831, 6883.346082122191, 6924.792256232321, 5657.2928383952, 5664.405237450091, 5677.37548869624, 5712.6286791358425, 5795.536357091422, 3495.702865256431, 3499.2651543176216, 3512.613612502623, 3604.225091605265, 3610.29599228148, 6377.405648587853, 6440.259370172396, 6474.255460621995, 6507.739690412425, 6519.771807986698, 6970.337817907291, 7017.824554386181, 7052.531613935082, 7059.364657180879, 7069.787906362817, 6537.542372034007, 6588.769393071219, 6700.128983232149, 6706.195256569145, 6711.295313991961, 6835.93164068353, 6855.177378714586, 6896.551724137915, 6914.377706006484, 6933.826654333682, 6857.417119544894, 6863.931360686329, 6867.862642747217, 6898.517103802686, 6901.413379862768, 6511.841756747879, 6532.020196970492, 6595.835104122435, 6626.635535045619, 6727.629980351127, 5052.292679024866, 5066.138756411493, 5083.212102124176, 5084.161113416245, 5095.949040509548, 6515.250746164252, 6709.698063587052, 6744.393004629607, 6946.9652651736415, 7003.509754317352, 6310.201592546102, 6643.667816609247, 6686.632235227109, 6712.664366781543, 6733.865322693421, 6513.413792758674, 6554.541182117397, 6637.6349300788925, 6663.233728121328, 6691.498137639794, 6303.744972143693, 6454.451371633464, 6479.157709497735, 6503.902441463287, 6542.771003014872, 6455.225372955276, 6530.8367290818105, 6563.409293163638, 6657.833554161185, 6659.602543084389, 6358.0, 6453.290138084713, 6465.418112369909, 6523.575967562093, 6575.145231120116], "value": 5242.222376779684, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [896.0278098263389, 900.2572877376165, 913.0914739833867, 916.2669864108711, 916.6883259691704, 18639.534011649717, 19440.0, 19447.70828437571, 19450.51373715658, 19468.9026554867, 17586.472405827815, 17620.11899405031, 17727.113644317764, 17739.73390399142, 17769.11154442279, 934.5374039850267, 942.0673533202149, 951.1202138022302, 953.8616900549416, 954.5990683912773, 979.2802290316612, 987.1017374189489, 989.3272574649271, 991.3407583956696, 991.3655260633201, 991.8313886639289, 1017.247237044589, 1028.1209565821227, 1028.5885645741726, 1028.5937054863325, 1007.0936157458347, 1014.0721240065332, 1014.3457469931926, 1014.5992333028449, 1021.6219998600528, 726.12501935168, 741.3846507398846, 747.816784887706, 749.1123019222184, 749.1123019222239, 19238.422847314603, 19386.127624256944, 19392.12735426909, 19459.4162175135, 19469.902650486798, 21876.89061554698, 22056.33830985073, 22488.437789055242, 22566.0, 22610.0, 17577.560560986076, 17722.20250088749, 17813.554661133447, 17840.375586854527, 17905.820941790676, 3685.63143685632, 3715.6284371562897, 3715.64701353371, 3718.3492888744363, 3719.9070023249365, 102717.0, 139630.30184849113, 139741.3012934939, 145361.0, 146609.99999999892, 17757.0, 18152.90923545374, 18259.817401826076, 18273.451796446127, 18287.268509259746, 31903.36193276168, 32507.0, 32742.50886236708, 32793.34413311721, 32819.0, 8876.8668469973, 8944.463332200088, 8972.102789720975, 9083.68207112748, 9112.362134650512, 4142.813573389205, 4165.271077561415, 4189.790510474464, 4215.135897141079, 4226.936595951063, 5561.805336813192, 5637.928793529216, 5703.686297253608, 5707.801361714087, 5726.341470730836, 1078.1644225725126, 1093.4314156638663, 1101.9724506887392, 1102.101787043557, 1103.475848971732, 651.2900937977532, 659.4790115808457, 674.0394937214547, 681.8772620928181, 684.4045680258207, 11703.882961170279, 11813.751218414833, 11887.465064072137, 12338.259704417764, 12673.746525069631, 641.9967900160469, 653.2618141500075, 653.4445721136996, 655.9836004099935, 664.4485077385855, 5979.790707325223, 6069.241344831896, 6109.389061093855, 6122.632642041492, 6157.599756015845, 120692.0, 123401.38299308626, 124994.0, 125369.37315313365, 127094.36452817677, 109275.45362273138, 109929.0, 110710.44644776724, 110766.0, 111226.0, 95766.0, 96193.0, 97575.51212243893, 99020.51469227967, 100193.0, 11079.556817727524, 11119.110471162126, 11198.888011119785, 11284.32294062359, 11420.94289528547, 44474.77762611166, 44819.327710085025, 45543.31685024794, 45641.31538026999, 45715.54284457246, 57905.13142302953, 59353.70323148529, 59567.40432595619, 59850.0, 61099.0, 14690.853091468949, 14850.034747741362, 15028.849711503182, 15159.317830697866, 15171.544853654408, 17832.91083544574, 18072.548186294924, 18133.365332213838, 18197.18112684906, 18378.448646540626, 14781.408743650563, 14865.702685946437, 14963.850361496246, 15069.47256846005, 15083.698326033636, 15517.922410387875, 15569.68860622804, 15629.92185039113, 15736.842631573538, 15742.055476671436, 14392.352344144749, 14512.056716313406, 14715.705685886436, 14828.110313381232, 14831.184284864004, 10914.563417463212, 11072.944635276772, 11327.716807079889, 11382.886171138183, 11470.254433461798, 9330.580123894577, 9427.717168484956, 9607.807843842944, 9621.951890240503, 9694.85457718149], "value": 8907.915834764352, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1408.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 109.0, 106.0, 108.0, 110.0, 107.0, 108.0, 108.0, 109.0, 107.0], "value": 108.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 116.0, 115.0, 129.0, 121.0, 118.0, 117.0, 117.0, 119.0], "value": 118.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 163.0, 164.0, 164.0, 163.0, 164.0, 173.0, 166.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 73.0, 73.0, 74.0, 74.0, 74.0, 74.0, 76.0, 74.0], "value": 73.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 79.0, 78.0, 77.0, 79.0, 80.0, 80.0, 80.0, 78.0], "value": 79.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 113.0, 114.0, 116.0, 114.0, 113.0, 111.0, 112.0, 112.0, 111.0], "value": 113.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 148.0, 150.0, 151.0, 150.0, 148.0, 149.0, 148.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 99.0, 99.0, 94.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 54.0, 51.0, 55.0, 53.0, 51.0, 53.0, 53.0, 52.0, 51.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 38.0, 37.0, 37.0, 37.0, 37.0, 38.0, 37.0, 37.0, 38.0], "value": 37.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 72.0, 73.0, 78.0, 74.0, 74.0, 72.0, 76.0, 76.0, 74.0], "value": 74.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 109.0, 116.0, 109.0, 117.0, 123.0, 112.0, 109.0, 119.0], "value": 114.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 167.0, 156.0, 160.0, 162.0, 168.0, 165.0, 162.0, 161.0, 159.0], "value": 163.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 64.0, 61.0, 64.0, 70.0, 68.0, 64.0, 70.0], "value": 65.2, "unit": "score"}]}]} 16:00:04 INFO - Return code: 0 16:00:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:00:05 INFO - # TBPL SUCCESS # 16:00:05 INFO - Running post-action listener: _package_coverage_data 16:00:05 INFO - Running post-action listener: _resource_record_post_action 16:00:05 INFO - [mozharness: 2017-09-29 23:00:05.015529Z] Finished run-tests step (success) 16:00:05 INFO - Running post-run listener: _resource_record_post_run 16:00:05 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 336711680; Read time: 12; Write time: 245856 16:00:05 INFO - TinderboxPrint: CPU usage
13.1% 16:00:05 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 16:00:05 INFO - TinderboxPrint: I/O write bytes / time
336,711,680 / 245,856 16:00:05 INFO - TinderboxPrint: CPU idle
8,222.9 (86.9%) 16:00:05 INFO - TinderboxPrint: CPU user
1,192.8 (12.6%) 16:00:05 INFO - TinderboxPrint: Swap in / out
0 / 0 16:00:05 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13770752; Read time: 0; Write time: 2232 16:00:05 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:00:05 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 0; Write bytes: 322433024; Read time: 0; Write time: 243620 16:00:05 INFO - Running post-run listener: _upload_blobber_files 16:00:05 INFO - Blob upload gear active. 16:00:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:00:05 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:00:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:00:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:00:06 INFO - (blobuploader) - INFO - Open directory for files ... 16:00:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 16:00:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:00:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:00:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 16:00:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:00:06 INFO - (blobuploader) - INFO - Done attempting. 16:00:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:00:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:00:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:00:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:00:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:00:10 INFO - (blobuploader) - INFO - Done attempting. 16:00:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 16:00:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:00:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:00:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 16:00:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:00:11 INFO - (blobuploader) - INFO - Done attempting. 16:00:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:00:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:00:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:00:12 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:00:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:00:12 INFO - (blobuploader) - INFO - Done attempting. 16:00:12 INFO - (blobuploader) - INFO - Iteration through files over. 16:00:12 INFO - Return code: 0 16:00:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:00:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:00:12 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d2b763b6efd7cb4a2d798beac43412b50fa4059277519cb0ca6260cc12eed820b35f761546c5cc804ceaef2e66363cb5db58c5b4b03346aa0d5e3f68279766a2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e514b04de14d9fc6d8124425b639df851e320f4d47c01c6acee9ef42682677cc76895ab6dc3da92bf093af828b42426eac6cfbbccd6f9d3601736df6517ba94b", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3a99603b0a6ae23f9d3a4cf8d634768c292aa21c4316e26334e1eddb21e79d0ad8482673e58aeb8d0ff8ec62de8c4aa6d99056670a6c95ab0b40eaae24776f6e", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e775fbc280c6e9a0337b93783c4a91cf66a91e2ce29037ee98197e70369ee94972393e6b4921f33c1c4a6f4a3a9a72a72331cf9cfeabc040ec914d5e71aa8093"} 16:00:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:00:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:00:12 INFO - Contents: 16:00:12 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d2b763b6efd7cb4a2d798beac43412b50fa4059277519cb0ca6260cc12eed820b35f761546c5cc804ceaef2e66363cb5db58c5b4b03346aa0d5e3f68279766a2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e514b04de14d9fc6d8124425b639df851e320f4d47c01c6acee9ef42682677cc76895ab6dc3da92bf093af828b42426eac6cfbbccd6f9d3601736df6517ba94b", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3a99603b0a6ae23f9d3a4cf8d634768c292aa21c4316e26334e1eddb21e79d0ad8482673e58aeb8d0ff8ec62de8c4aa6d99056670a6c95ab0b40eaae24776f6e", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e775fbc280c6e9a0337b93783c4a91cf66a91e2ce29037ee98197e70369ee94972393e6b4921f33c1c4a6f4a3a9a72a72331cf9cfeabc040ec914d5e71aa8093"} 16:00:12 INFO - Running post-run listener: copy_logs_to_upload_dir 16:00:12 INFO - Copying logs to upload dir... 16:00:12 INFO - mkdir: /builds/slave/test/build/upload/logs 16:00:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.474915 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-09-29 16:00:12.842011) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-29 16:00:12.850065) ========= 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=ed14279e38b05397cf4aa391000001a4-1506721513.636646-961579602 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/d2b763b6efd7cb4a2d798beac43412b50fa4059277519cb0ca6260cc12eed820b35f761546c5cc804ceaef2e66363cb5db58c5b4b03346aa0d5e3f68279766a2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e514b04de14d9fc6d8124425b639df851e320f4d47c01c6acee9ef42682677cc76895ab6dc3da92bf093af828b42426eac6cfbbccd6f9d3601736df6517ba94b", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3a99603b0a6ae23f9d3a4cf8d634768c292aa21c4316e26334e1eddb21e79d0ad8482673e58aeb8d0ff8ec62de8c4aa6d99056670a6c95ab0b40eaae24776f6e", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e775fbc280c6e9a0337b93783c4a91cf66a91e2ce29037ee98197e70369ee94972393e6b4921f33c1c4a6f4a3a9a72a72331cf9cfeabc040ec914d5e71aa8093"} build_url:https://queue.taskcluster.net/v1/task/G34YYNMNSWCHGxZu1JukKw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011247 build_url: 'https://queue.taskcluster.net/v1/task/G34YYNMNSWCHGxZu1JukKw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d2b763b6efd7cb4a2d798beac43412b50fa4059277519cb0ca6260cc12eed820b35f761546c5cc804ceaef2e66363cb5db58c5b4b03346aa0d5e3f68279766a2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e514b04de14d9fc6d8124425b639df851e320f4d47c01c6acee9ef42682677cc76895ab6dc3da92bf093af828b42426eac6cfbbccd6f9d3601736df6517ba94b", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3a99603b0a6ae23f9d3a4cf8d634768c292aa21c4316e26334e1eddb21e79d0ad8482673e58aeb8d0ff8ec62de8c4aa6d99056670a6c95ab0b40eaae24776f6e", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e775fbc280c6e9a0337b93783c4a91cf66a91e2ce29037ee98197e70369ee94972393e6b4921f33c1c4a6f4a3a9a72a72331cf9cfeabc040ec914d5e71aa8093"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-29 16:00:12.886394) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 16:00:12.886832) ========= 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=ed14279e38b05397cf4aa391000001a4-1506721513.636646-961579602 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 16:00:12.969484) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-29 16:00:12.972814) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-29 16:00:12.973132) ========= ========= Total master_lag: 0.32 =========