builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-076 starttime: 1506724765.87 results: success (0) revision: 64c8107a2a13895e9e4295806bf65b99639cb651 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-29 15:39:25.870314) ========= 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.870785) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-29 15:39:25.871059) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-29 15:39:25.987268) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 15:39:25.987650) ========= 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=9bfb7e13875ed353a705960e000001c0-1506723941.230278-256094443 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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 44.5M=0s 2017-09-29 15:39:26 (44.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.146196 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 15:39:26.176630) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 15:39:26.176929) ========= 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=9bfb7e13875ed353a705960e000001c0-1506723941.230278-256094443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014679 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 15:39:26.239121) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 12 secs) (at 2017-09-29 15:39:26.239499) ========= 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=9bfb7e13875ed353a705960e000001c0-1506723941.230278-256094443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-29 15:39:26,250 truncating revision to first 12 chars 2017-09-29 15:39:26,250 Setting DEBUG logging. 2017-09-29 15:39:26,250 attempt 1/10 2017-09-29 15:39:26,250 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,922 attempt 1/10 2017-09-29 15:39:27,802 current task status: no status available at this point. state: STARTED 2017-09-29 15:39:27,803 sleeping for 10.00s (attempt 1/10) 2017-09-29 15:39:37,813 attempt 2/10 2017-09-29 15:39:38,162 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-09-29 15:39:38,329 unpacking tar archive at: mozilla-central-64c8107a2a13/testing/mozharness/ program finished with exit code 0 elapsedTime=12.384174 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 12 secs) (at 2017-09-29 15:39:38.654466) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-29 15:39:38.657809) ========= script_repo_revision: 64c8107a2a13895e9e4295806bf65b99639cb651 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-29 15:39:38.658189) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-29 15:39:38.658483) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-29 15:39:38.674204) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-29 15:39:38.674562) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9bfb7e13875ed353a705960e000001c0-1506723941.230278-256094443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:39:38 INFO - MultiFileLogger online at 20170929 15:39:38 in /builds/slave/test 15:39:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 15:39:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:39:38 INFO - {'append_to_log': False, 15:39:38 INFO - 'base_work_dir': '/builds/slave/test', 15:39:38 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:39:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:39:38 INFO - 'branch': 'Firefox-Non-PGO', 15:39:38 INFO - 'buildbot_json_path': 'buildprops.json', 15:39:38 INFO - 'code_coverage': False, 15:39:38 INFO - 'config_files': ('talos/linux_config.py',), 15:39:38 INFO - 'default_actions': ('clobber', 15:39:38 INFO - 'read-buildbot-config', 15:39:38 INFO - 'download-and-extract', 15:39:38 INFO - 'populate-webroot', 15:39:38 INFO - 'create-virtualenv', 15:39:38 INFO - 'install', 15:39:38 INFO - 'setup-mitmproxy', 15:39:38 INFO - 'run-tests'), 15:39:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:39:38 INFO - 'disable_ccov_upload': False, 15:39:38 INFO - 'disable_stylo': False, 15:39:38 INFO - 'download_minidump_stackwalk': True, 15:39:38 INFO - 'download_symbols': 'ondemand', 15:39:38 INFO - 'enable_stylo': False, 15:39:38 INFO - 'enable_webrender': False, 15:39:38 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:39:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:39:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:39:38 INFO - 'gecko_profile': False, 15:39:38 INFO - 'gecko_profile_interval': 0, 15:39:38 INFO - 'installer_path': 'installer.exe', 15:39:38 INFO - 'log_level': 'info', 15:39:38 INFO - 'log_name': 'talos', 15:39:38 INFO - 'log_to_console': True, 15:39:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:39:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:39:38 INFO - 'opt_config_files': (), 15:39:38 INFO - 'pip_index': False, 15:39:38 INFO - 'suite': 'dromaeojs-e10s', 15:39:38 INFO - 'system_bits': '32', 15:39:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:39:38 INFO - 'title': 'talos-linux64-ix-076', 15:39:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:39:38 INFO - 'use_talos_json': True, 15:39:38 INFO - 'verify': 'False', 15:39:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:39:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:39:38 INFO - 'work_dir': 'build'} 15:39:38 INFO - [mozharness: 2017-09-29 22:39:38.821595Z] Running clobber step. 15:39:38 INFO - Running pre-action listener: _resource_record_pre_action 15:39:38 INFO - Running main action method: clobber 15:39:38 INFO - rmtree: /builds/slave/test/build 15:39:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:39:39 INFO - Running post-action listener: _resource_record_post_action 15:39:39 INFO - [mozharness: 2017-09-29 22:39:39.816232Z] Finished clobber step (success) 15:39:39 INFO - [mozharness: 2017-09-29 22:39:39.816329Z] Running read-buildbot-config step. 15:39:39 INFO - Running pre-action listener: _resource_record_pre_action 15:39:39 INFO - Running main action method: read_buildbot_config 15:39:39 INFO - Using buildbot properties: 15:39:39 INFO - { 15:39:39 INFO - "project": "", 15:39:39 INFO - "product": "firefox", 15:39:39 INFO - "who": "kwierso@gmail.com", 15:39:39 INFO - "installer_path": "public/build/target.tar.bz2", 15:39:39 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 15:39:39 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:39:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 15:39:39 INFO - "stage_platform": "linux64", 15:39:39 INFO - "basedir": "/builds/slave/test", 15:39:39 INFO - "buildnumber": 883, 15:39:39 INFO - "platform": "ubuntu64_hw", 15:39:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:39:39 INFO - "slavebuilddir": "test", 15:39:39 INFO - "taskId": "PRO3yWOhR5GfDd7HbU-IEw", 15:39:39 INFO - "branch": "mozilla-central", 15:39:39 INFO - "script_repo_revision": "production", 15:39:39 INFO - "revision": "64c8107a2a13895e9e4295806bf65b99639cb651", 15:39:39 INFO - "slavename": "talos-linux64-ix-076", 15:39:39 INFO - "repo_path": "mozilla-central" 15:39:39 INFO - } 15:39:39 INFO - Finding installer, test and symbols from parent task. 15:39:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PRO3yWOhR5GfDd7HbU-IEw'}, attempt #1 15:39:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PRO3yWOhR5GfDd7HbU-IEw'}, attempt #1 15:39:40 INFO - Task dependencies: G34YYNMNSWCHGxZu1JukKw 15:39:40 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.173694Z] Finished read-buildbot-config step (success) 15:39:41 INFO - [mozharness: 2017-09-29 22:39:41.173911Z] 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:41 INFO - Downloaded 989 bytes. 15:39:41 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:39:41 INFO - Using the following test package requirements: 15:39:41 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:39:41 INFO - u'common': [u'target.common.tests.zip'], 15:39:41 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:39:41 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:39:41 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:39:41 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:39:41 INFO - u'mozbase': [u'target.common.tests.zip'], 15:39:41 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:39:41 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:39:41 INFO - u'web-platform': [u'target.common.tests.zip', 15:39:41 INFO - u'target.web-platform.tests.tar.gz'], 15:39:41 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:39:41 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 15:39:41 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:41 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:41 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.446908Z] Finished download-and-extract step (success) 15:39:56 INFO - [mozharness: 2017-09-29 22:39:56.447072Z] 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:56 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:39:56 INFO - 'tests': ['tresize', 15:39:56 INFO - 'tcanvasmark']}, 15:39:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:39:56 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:39:56 INFO - 'tests': ['dromaeo_css', 15:39:56 INFO - 'kraken']}, 15:39:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:39:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:39:56 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:39:56 INFO - 'talos_options': ['--disable-stylo'], 15:39:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:39:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:39:56 INFO - 'tests': ['damp', 'tps']}, 15:39:56 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:39:56 INFO - 'talos_options': ['--disable-stylo'], 15:39:56 INFO - 'tests': ['damp', 'tps']}, 15:39:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:39:56 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:39:56 INFO - 'tests': ['dromaeo_dom']}, 15:39:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:39:56 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:39:56 INFO - 'tests': ['basic_compositor_video', 15:39:56 INFO - 'glvideo']}, 15:39:56 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:39:56 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:39:56 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:39:56 INFO - 'talos_options': ['--disable-stylo'], 15:39:56 INFO - 'tests': ['ts_paint_webext', 15:39:56 INFO - 'tp5o_webext']}, 15:39:56 INFO - 'other-e10s': {'tests': ['a11yr', 15:39:56 INFO - 'ts_paint', 15:39:56 INFO - 'tpaint', 15:39:56 INFO - 'sessionrestore', 15:39:56 INFO - 'sessionrestore_many_windows', 15:39:56 INFO - 'sessionrestore_no_auto_restore', 15:39:56 INFO - 'tabpaint', 15:39:56 INFO - 'cpstartup']}, 15:39:56 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:39:56 INFO - 'tests': ['a11yr', 15:39:56 INFO - 'ts_paint', 15:39:56 INFO - 'tpaint', 15:39:56 INFO - 'sessionrestore', 15:39:56 INFO - 'sessionrestore_many_windows', 15:39:56 INFO - 'sessionrestore_no_auto_restore', 15:39:56 INFO - 'tabpaint', 15:39:56 INFO - 'cpstartup']}, 15:39:56 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 15:39:56 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 15:39:56 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:39:56 INFO - 'tests': ['perf_reftest_singletons']}, 15:39:56 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:39:56 INFO - 'tests': ['perf_reftest']}, 15:39:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:39:56 INFO - 'tsvgr_opacity', 15:39:56 INFO - 'tart', 15:39:56 INFO - 'tscrollx', 15:39:56 INFO - 'tsvg_static']}, 15:39:56 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:39:56 INFO - 'tests': ['tsvgx', 15:39:56 INFO - 'tsvgr_opacity', 15:39:56 INFO - 'tart', 15:39:56 INFO - 'tscrollx', 15:39:56 INFO - 'tsvg_static']}, 15:39:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:39:56 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:39:56 INFO - 'talos_options': ['--disable-stylo'], 15:39:56 INFO - 'tests': ['tp5o']}, 15:39:56 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:39:56 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 15:39:56 INFO - 'talos_options': ['--mitmproxy', 15:39:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:39:56 INFO - '--firstNonBlankPaint'], 15:39:56 INFO - 'tests': ['tp6_google', 15:39:56 INFO - 'tp6_youtube', 15:39:56 INFO - 'tp6_amazon', 15:39:56 INFO - 'tp6_facebook']}, 15:39:56 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:39:56 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 15:39:56 INFO - 'talos_options': ['--disable-stylo', 15:39:56 INFO - '--mitmproxy', 15:39:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:39:56 INFO - '--firstNonBlankPaint'], 15:39:56 INFO - 'tests': ['tp6_google', 15:39:56 INFO - 'tp6_youtube', 15:39:56 INFO - 'tp6_amazon', 15:39:56 INFO - 'tp6_facebook']}, 15:39:56 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:39:56 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 15:39:56 INFO - 'talos_options': ['--stylo-threads=1', 15:39:56 INFO - '--mitmproxy', 15:39:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:39:56 INFO - '--firstNonBlankPaint'], 15:39:56 INFO - 'tests': ['tp6_google', 15:39:56 INFO - 'tp6_youtube', 15:39:56 INFO - 'tp6_amazon', 15:39:56 INFO - 'tp6_facebook']}, 15:39:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:39:56 INFO - 'talos_options': ['--xperf_path', 15:39:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:39:56 INFO - 'tests': ['tp5n']}, 15:39:56 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:39:56 INFO - 'talos_options': ['--disable-stylo', 15:39:56 INFO - '--xperf_path', 15:39:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:39:56 INFO - 'tests': ['tp5n']}}} 15:39:56 INFO - Running post-action listener: _resource_record_post_action 15:39:56 INFO - [mozharness: 2017-09-29 22:39:56.543699Z] Finished populate-webroot step (success) 15:39:56 INFO - [mozharness: 2017-09-29 22:39:56.543849Z] Running create-virtualenv step. 15:39:56 INFO - Running pre-action listener: _resource_record_pre_action 15:39:56 INFO - Running main action method: create_virtualenv 15:39:56 INFO - Creating virtualenv /builds/slave/test/build/venv 15:39:56 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:39:56 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:39:56 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:39:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:39:56 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:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:39:57 INFO - Reading from file tmpfile_stdout 15:39:57 INFO - Output received: 15:39:57 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 15:39:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:39:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc39c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0d60>, '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 0x1fc1a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc1ef0>, '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': '9bfb7e13875ed353a705960e000001c0-1506723941.230278-256094443', '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:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:39:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:39:57 INFO - Using env: {'DISPLAY': ':0', 15:39:57 INFO - 'HOME': '/home/cltbld', 15:39:57 INFO - 'LANG': 'en_US.UTF-8', 15:39:57 INFO - 'LANGUAGE': 'en_US:en', 15:39:57 INFO - 'LOGNAME': 'cltbld', 15:39:57 INFO - 'MAIL': '/var/mail/cltbld', 15:39:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:57 INFO - 'MOZ_NO_REMOTE': '1', 15:39:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:57 INFO - 'NO_EM_RESTART': '1', 15:39:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:57 INFO - 'PWD': '/builds/slave/test', 15:39:57 INFO - 'SHELL': '/bin/bash', 15:39:57 INFO - 'SHLVL': '1', 15:39:57 INFO - 'TERM': 'linux', 15:39:57 INFO - 'TMOUT': '86400', 15:39:57 INFO - 'USER': 'cltbld', 15:39:57 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506723941.230278-256094443', 15:39:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:57 INFO - '_': '/tools/buildbot/bin/python'} 15:39:58 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:39:58 INFO - Downloading/unpacking pip>=1.5 15:39:58 INFO - Running setup.py egg_info for package pip 15:39:58 INFO - warning: no files found matching 'pip/cacert.pem' 15:39:58 INFO - warning: no files found matching '*.html' under directory 'docs' 15:39:58 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:39:58 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:39:58 INFO - Installing collected packages: pip 15:39:58 INFO - Found existing installation: pip 1.1 15:39:58 INFO - Uninstalling pip: 15:39:58 INFO - Successfully uninstalled pip 15:39:58 INFO - Running setup.py install for pip 15:39:58 INFO - warning: no files found matching 'pip/cacert.pem' 15:39:58 INFO - warning: no files found matching '*.html' under directory 'docs' 15:39:58 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:39:58 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:39:58 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:39:58 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:39:58 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:39:58 INFO - Successfully installed pip 15:39:58 INFO - Cleaning up... 15:39:58 INFO - Return code: 0 15:39:58 INFO - Installing psutil>=3.1.1 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', '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 0x1c561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc39c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0d60>, '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 0x1fc1a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc1ef0>, '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': '9bfb7e13875ed353a705960e000001c0-1506723941.230278-256094443', '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', 'psutil>=3.1.1'] 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 psutil>=3.1.1 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': '9bfb7e13875ed353a705960e000001c0-1506723941.230278-256094443', 15:39:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:58 INFO - '_': '/tools/buildbot/bin/python'} 15:39:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:58 INFO - Downloading/unpacking psutil>=3.1.1 15:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 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:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:40:00 INFO - building 'psutil._psutil_posix' extension 15:40:00 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:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 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 - Successfully installed psutil 15:40:00 INFO - Cleaning up... 15:40:00 INFO - Return code: 0 15:40:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:40:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc39c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0d60>, '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 0x1fc1a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc1ef0>, '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': '9bfb7e13875ed353a705960e000001c0-1506723941.230278-256094443', '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:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:40:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:40:00 INFO - Using env: {'DISPLAY': ':0', 15:40:00 INFO - 'HOME': '/home/cltbld', 15:40:00 INFO - 'LANG': 'en_US.UTF-8', 15:40:00 INFO - 'LANGUAGE': 'en_US:en', 15:40:00 INFO - 'LOGNAME': 'cltbld', 15:40:00 INFO - 'MAIL': '/var/mail/cltbld', 15:40:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:00 INFO - 'MOZ_NO_REMOTE': '1', 15:40:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:00 INFO - 'NO_EM_RESTART': '1', 15:40:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:00 INFO - 'PWD': '/builds/slave/test', 15:40:00 INFO - 'SHELL': '/bin/bash', 15:40:00 INFO - 'SHLVL': '1', 15:40:00 INFO - 'TERM': 'linux', 15:40:00 INFO - 'TMOUT': '86400', 15:40:00 INFO - 'USER': 'cltbld', 15:40:00 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506723941.230278-256094443', 15:40:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:00 INFO - '_': '/tools/buildbot/bin/python'} 15:40:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 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 0x1c561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc39c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0d60>, '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 0x1fc1a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc1ef0>, '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': '9bfb7e13875ed353a705960e000001c0-1506723941.230278-256094443', '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': '9bfb7e13875ed353a705960e000001c0-1506723941.230278-256094443', 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:05 INFO - warning: no files found matching '*.txt' 15:40:05 INFO - no previously-included directories found matching 'build' 15:40:05 INFO - no previously-included directories found matching 'dist' 15:40:05 INFO - no previously-included directories found matching '.git*' 15:40:05 INFO - Successfully installed jsonschema functools32 15:40:05 INFO - Cleaning up... 15:40:05 INFO - Return code: 0 15:40:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:40:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc39c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0d60>, '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 0x1fc1a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc1ef0>, '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': '9bfb7e13875ed353a705960e000001c0-1506723941.230278-256094443', '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:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:40:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:40:05 INFO - Using env: {'DISPLAY': ':0', 15:40:05 INFO - 'HOME': '/home/cltbld', 15:40:05 INFO - 'LANG': 'en_US.UTF-8', 15:40:05 INFO - 'LANGUAGE': 'en_US:en', 15:40:05 INFO - 'LOGNAME': 'cltbld', 15:40:05 INFO - 'MAIL': '/var/mail/cltbld', 15:40:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:05 INFO - 'MOZ_NO_REMOTE': '1', 15:40:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:05 INFO - 'NO_EM_RESTART': '1', 15:40:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:05 INFO - 'PWD': '/builds/slave/test', 15:40:05 INFO - 'SHELL': '/bin/bash', 15:40:05 INFO - 'SHLVL': '1', 15:40:05 INFO - 'TERM': 'linux', 15:40:05 INFO - 'TMOUT': '86400', 15:40:05 INFO - 'USER': 'cltbld', 15:40:05 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506723941.230278-256094443', 15:40:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:05 INFO - '_': '/tools/buildbot/bin/python'} 15:40:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:40:05 INFO - Cleaning up... 15:40:05 INFO - Return code: 0 15:40:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:40:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1c561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc39c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0d60>, '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 0x1fc1a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc1ef0>, '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': '9bfb7e13875ed353a705960e000001c0-1506723941.230278-256094443', '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:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:40:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:40:05 INFO - Using env: {'DISPLAY': ':0', 15:40:05 INFO - 'HOME': '/home/cltbld', 15:40:05 INFO - 'LANG': 'en_US.UTF-8', 15:40:05 INFO - 'LANGUAGE': 'en_US:en', 15:40:05 INFO - 'LOGNAME': 'cltbld', 15:40:05 INFO - 'MAIL': '/var/mail/cltbld', 15:40:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:05 INFO - 'MOZ_NO_REMOTE': '1', 15:40:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:05 INFO - 'NO_EM_RESTART': '1', 15:40:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:05 INFO - 'PWD': '/builds/slave/test', 15:40:05 INFO - 'SHELL': '/bin/bash', 15:40:05 INFO - 'SHLVL': '1', 15:40:05 INFO - 'TERM': 'linux', 15:40:05 INFO - 'TMOUT': '86400', 15:40:05 INFO - 'USER': 'cltbld', 15:40:05 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506723941.230278-256094443', 15:40:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:05 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:07 INFO - Downloading/unpacking docopt==0.6.1 (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 - Downloading docopt-0.6.1.tar.gz 15:40:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:40:07 INFO - Installing collected packages: blobuploader, requests, docopt 15:40:07 INFO - Running setup.py install for blobuploader 15:40:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:40:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:40:07 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 0x1c561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc39c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0d60>, '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 0x1fc1a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc1ef0>, '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': '9bfb7e13875ed353a705960e000001c0-1506723941.230278-256094443', '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': '9bfb7e13875ed353a705960e000001c0-1506723941.230278-256094443', 15:40:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:08 INFO - '_': '/tools/buildbot/bin/python'} 15:40:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:40:08 INFO - Running setup.py (path:/tmp/pip-cBuzbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:40:08 INFO - Running setup.py (path:/tmp/pip-VJ3np_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:40:08 INFO - Running setup.py (path:/tmp/pip-NS91KF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:40:08 INFO - Running setup.py (path:/tmp/pip-sQAHFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:40:08 INFO - Running setup.py (path:/tmp/pip-rgyBro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:40:08 INFO - Running setup.py (path:/tmp/pip-0eRvjb-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-t_U07c-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-9RFP0o-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-N_SaaC-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-NCUm5L-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-dinMLy-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-XkTU2N-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-84xDIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:40:09 INFO - Running setup.py (path:/tmp/pip-p3SRGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:40:09 INFO - Running setup.py (path:/tmp/pip-oEoif4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:40:09 INFO - Running setup.py (path:/tmp/pip-XfY_8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:40:09 INFO - Running setup.py (path:/tmp/pip-RKfj8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:40:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:40:09 INFO - Running setup.py install for manifestparser 15:40:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:40:09 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:10 INFO - Running setup.py install for mozInstall 15:40:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:40:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:40:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:40:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:40:10 INFO - Running setup.py install for mozleak 15:40:10 INFO - Running setup.py install for mozlog 15:40:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:40:10 INFO - Running setup.py install for moznetwork 15:40:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:40:10 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:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:40:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:40:11 INFO - Cleaning up... 15:40:11 INFO - Return code: 0 15:40:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:40:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:11 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 0x1c561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc39c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0d60>, '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 0x1fc1a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc1ef0>, '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': '9bfb7e13875ed353a705960e000001c0-1506723941.230278-256094443', '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:11 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:11 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:11 INFO - Using env: {'DISPLAY': ':0', 15:40:11 INFO - 'HOME': '/home/cltbld', 15:40:11 INFO - 'LANG': 'en_US.UTF-8', 15:40:11 INFO - 'LANGUAGE': 'en_US:en', 15:40:11 INFO - 'LOGNAME': 'cltbld', 15:40:11 INFO - 'MAIL': '/var/mail/cltbld', 15:40:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:11 INFO - 'MOZ_NO_REMOTE': '1', 15:40:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:11 INFO - 'NO_EM_RESTART': '1', 15:40:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:11 INFO - 'PWD': '/builds/slave/test', 15:40:11 INFO - 'SHELL': '/bin/bash', 15:40:11 INFO - 'SHLVL': '1', 15:40:11 INFO - 'TERM': 'linux', 15:40:11 INFO - 'TMOUT': '86400', 15:40:11 INFO - 'USER': 'cltbld', 15:40:11 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506723941.230278-256094443', 15:40:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:11 INFO - '_': '/tools/buildbot/bin/python'} 15:40:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:40:11 INFO - Running setup.py (path:/tmp/pip-_GkhWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:40:11 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:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:40:11 INFO - Running setup.py (path:/tmp/pip-IUuo9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:40:11 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:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:40:11 INFO - Running setup.py (path:/tmp/pip-F6P5l4-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-Gb0VGc-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-0l4Xvl-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-wbovUP-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-l1d3VX-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-zQZB93-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-euuKNQ-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-Nr5hPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:40:12 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:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:40:12 INFO - Running setup.py (path:/tmp/pip-NjNP8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:40:12 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:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:40:12 INFO - Running setup.py (path:/tmp/pip-TpJ8It-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:40:12 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:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:40:12 INFO - Running setup.py (path:/tmp/pip-o5FaXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:40:12 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:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:40:12 INFO - Running setup.py (path:/tmp/pip-YPb5Z6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:40:12 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:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:40:12 INFO - Running setup.py (path:/tmp/pip-oGn5Gg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:40:12 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:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:40:12 INFO - Running setup.py (path:/tmp/pip-XKo1hr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:40:12 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:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:40:12 INFO - Running setup.py (path:/tmp/pip-Sr05n4-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:14 INFO - Reading from file tmpfile_stdout 15:40:14 INFO - Current package versions: 15:40:14 INFO - argparse == 1.2.1 15:40:14 INFO - blessings == 1.6 15:40:14 INFO - blobuploader == 1.2.4 15:40:14 INFO - docopt == 0.6.1 15:40:14 INFO - functools32 == 3.2.3-2 15:40:14 INFO - jsonschema == 2.5.1 15:40:14 INFO - manifestparser == 1.1 15:40:14 INFO - mozInstall == 1.13 15:40:14 INFO - mozcrash == 1.0 15:40:14 INFO - mozdebug == 0.1 15:40:14 INFO - mozdevice == 0.51 15:40:14 INFO - mozfile == 1.2 15:40:14 INFO - mozhttpd == 0.7 15:40:14 INFO - mozinfo == 0.10 15:40:14 INFO - mozleak == 0.1 15:40:14 INFO - mozlog == 3.5 15:40:14 INFO - moznetwork == 0.27 15:40:14 INFO - mozprocess == 0.25 15:40:14 INFO - mozprofile == 0.28 15:40:14 INFO - mozrunner == 6.13 15:40:14 INFO - mozscreenshot == 0.1 15:40:14 INFO - mozsystemmonitor == 0.3 15:40:14 INFO - moztest == 0.8 15:40:14 INFO - mozversion == 1.4 15:40:14 INFO - psutil == 3.1.1 15:40:14 INFO - requests == 1.2.3 15:40:14 INFO - wsgiref == 0.1.2 15:40:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:40:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:14 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 0x1c561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc39c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0d60>, '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 0x1fc1a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc1ef0>, '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': '9bfb7e13875ed353a705960e000001c0-1506723941.230278-256094443', '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:14 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:14 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:14 INFO - Using env: {'DISPLAY': ':0', 15:40:14 INFO - 'HOME': '/home/cltbld', 15:40:14 INFO - 'LANG': 'en_US.UTF-8', 15:40:14 INFO - 'LANGUAGE': 'en_US:en', 15:40:14 INFO - 'LOGNAME': 'cltbld', 15:40:14 INFO - 'MAIL': '/var/mail/cltbld', 15:40:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:14 INFO - 'MOZ_NO_REMOTE': '1', 15:40:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:14 INFO - 'NO_EM_RESTART': '1', 15:40:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:14 INFO - 'PWD': '/builds/slave/test', 15:40:14 INFO - 'SHELL': '/bin/bash', 15:40:14 INFO - 'SHLVL': '1', 15:40:14 INFO - 'TERM': 'linux', 15:40:14 INFO - 'TMOUT': '86400', 15:40:14 INFO - 'USER': 'cltbld', 15:40:14 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506723941.230278-256094443', 15:40:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:14 INFO - '_': '/tools/buildbot/bin/python'} 15:40:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:14 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:14 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:14 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:14 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:14 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:14 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:14 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:14 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:14 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:14 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:40:15 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:15 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:15 INFO - Installing collected packages: simplejson 15:40:15 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:16 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:16 INFO - Successfully installed simplejson 15:40:16 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 0x1c561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1eb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fc39c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc0d60>, '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 0x1fc1a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc1ef0>, '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': '9bfb7e13875ed353a705960e000001c0-1506723941.230278-256094443', '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': '9bfb7e13875ed353a705960e000001c0-1506723941.230278-256094443', 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.291075Z] Finished create-virtualenv step (success) 15:40:17 INFO - [mozharness: 2017-09-29 22:40:17.291548Z] 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:17 INFO - Reading from file tmpfile_stdout 15:40:17 INFO - Detecting whether we're running mozinstall >=1.0... 15:40:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:40:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:40:17 INFO - Reading from file tmpfile_stdout 15:40:17 INFO - Output received: 15:40:17 INFO - Usage: mozinstall [options] installer 15:40:17 INFO - Options: 15:40:17 INFO - -h, --help show this help message and exit 15:40:17 INFO - -d DEST, --destination=DEST 15:40:17 INFO - Directory to install application into. [default: 15:40:17 INFO - "/builds/slave/test"] 15:40:17 INFO - --app=APP Application being installed. [default: firefox] 15:40:17 INFO - mkdir: /builds/slave/test/build/application 15:40:17 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:17 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.415435Z] Finished install step (success) 15:40:35 INFO - [mozharness: 2017-09-29 22:40:35.415579Z] 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.416374Z] Finished setup-mitmproxy step (success) 15:40:35 INFO - [mozharness: 2017-09-29 22:40:35.416608Z] 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 0x1fc0d60>, '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 0x1fc1a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fc1ef0>, '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:35 INFO - Return code: 0 15:40:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:40:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:40:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:40:35 INFO - ENV: RUST_BACKTRACE is now full 15:40:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:40:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:40:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G34YYNMNSWCHGxZu1JukKw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:40:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/G34YYNMNSWCHGxZu1JukKw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-076 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:40:35 INFO - Using env: {'DISPLAY': ':0', 15:40:35 INFO - 'HOME': '/home/cltbld', 15:40:35 INFO - 'LANG': 'en_US.UTF-8', 15:40:35 INFO - 'LANGUAGE': 'en_US:en', 15:40:35 INFO - 'LOGNAME': 'cltbld', 15:40:35 INFO - 'MAIL': '/var/mail/cltbld', 15:40:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:40:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:40:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:35 INFO - 'MOZ_NO_REMOTE': '1', 15:40:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:40:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:35 INFO - 'NO_EM_RESTART': '1', 15:40:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:35 INFO - 'PWD': '/builds/slave/test', 15:40:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:40:35 INFO - 'RUST_BACKTRACE': 'full', 15:40:35 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:40:35 INFO - 'SHELL': '/bin/bash', 15:40:35 INFO - 'SHLVL': '1', 15:40:35 INFO - 'TERM': 'linux', 15:40:35 INFO - 'TMOUT': '86400', 15:40:35 INFO - 'USER': 'cltbld', 15:40:35 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506723941.230278-256094443', 15:40:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:35 INFO - '_': '/tools/buildbot/bin/python'} 15:40:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G34YYNMNSWCHGxZu1JukKw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:40:35 INFO - mozversion application_buildid: 20170929214553 15:40:35 INFO - mozversion application_changeset: 64c8107a2a13895e9e4295806bf65b99639cb651 15:40:35 INFO - mozversion application_display_name: Nightly 15:40:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:40:35 INFO - mozversion application_name: Firefox 15:40:35 INFO - mozversion application_remotingname: firefox 15:40:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:40:35 INFO - mozversion application_vendor: Mozilla 15:40:35 INFO - mozversion application_version: 58.0a1 15:40:35 INFO - mozversion platform_buildid: 20170929214553 15:40:35 INFO - mozversion platform_changeset: 64c8107a2a13895e9e4295806bf65b99639cb651 15:40:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:40:35 INFO - mozversion platform_version: 58.0a1 15:40:35 INFO - using testdate: 1506724835 15:40:35 INFO - actual date: 1506724835 15:40:35 INFO - starting webserver on 'localhost:54893' 15:40:35 INFO - SUITE-START | Running 2 tests 15:40:35 INFO - TEST-START | dromaeo_css 15:40:35 INFO - Initialising browser for dromaeo_css test... 15:40:35 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54893/getInfo.html -profile /tmp/tmpqB4UDX/profile 15:40:35 INFO - TEST-INFO | started process 29636 (/builds/slave/test/build/application/firefox/firefox http://localhost:54893/getInfo.html) 15:40:41 INFO - TEST-INFO | 29636: 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 - 'TERM': 'linux', 15:40:41 INFO - 'TMOUT': '86400', 15:40:41 INFO - 'USER': 'cltbld', 15:40:41 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506723941.230278-256094443', 15:40:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:41 INFO - '_': '/tools/buildbot/bin/python'} 15:40:41 INFO - TEST-INFO | started process 29866 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqB4UDX/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 29866 | 15:40:42 INFO - PID 29866 | (/builds/slave/test/build/application/firefox/firefox:29915): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:40:42 INFO - PID 29866 | 15:40:52 INFO - PID 29866 | RSS: Main: 153530368 15:40:52 INFO - PID 29866 | 15:43:50 INFO - PID 29866 | Cycle 1(1): loaded http://localhost:54893/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54893/tests/dromaeo/cssquery-ext.html) 15:43:51 INFO - PID 29866 | RSS: Main: 151105536 15:43:51 INFO - PID 29866 | 15:46:53 INFO - PID 29866 | Cycle 1(1): loaded http://localhost:54893/tests/dromaeo/cssquery-ext.html (next: http://localhost:54893/tests/dromaeo/cssquery-jquery.html) 15:46:54 INFO - PID 29866 | RSS: Main: 151797760 15:46:54 INFO - PID 29866 | 15:49:56 INFO - PID 29866 | Cycle 1(1): loaded http://localhost:54893/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54893/tests/dromaeo/cssquery-mootools.html) 15:49:56 INFO - PID 29866 | RSS: Main: 152481792 15:49:56 INFO - PID 29866 | 15:52:58 INFO - PID 29866 | Cycle 1(1): loaded http://localhost:54893/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54893/tests/dromaeo/cssquery-prototype.html) 15:52:58 INFO - PID 29866 | RSS: Main: 152006656 15:52:58 INFO - PID 29866 | 15:56:02 INFO - PID 29866 | Cycle 1(1): loaded http://localhost:54893/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54893/tests/dromaeo/cssquery-yui.html) 15:56:02 INFO - PID 29866 | RSS: Main: 155099136 15:56:02 INFO - PID 29866 | 15:59:04 INFO - PID 29866 | Cycle 1(1): loaded http://localhost:54893/tests/dromaeo/cssquery-yui.html (next: http://localhost:54893/tests/dromaeo/cssquery-dojo.html) 15:59:04 INFO - PID 29866 | RSS: Main: 156389376 15:59:04 INFO - PID 29866 | 15:59:04 INFO - PID 29866 | __start_tp_report 15:59:04 INFO - PID 29866 | _x_x_mozilla_page_load 15:59:04 INFO - PID 29866 | _x_x_mozilla_page_load_details 15:59:04 INFO - PID 29866 | |i|pagename|runs| 15:59:04 INFO - PID 29866 | |0;dojo.html;3160.7313378362837;3193.8083714977097;3219.613646362437;3225.483922572389;3227.5158726191084;6278.529110316722;6367.6816159192085;6437.967810160949;6468.867948109074;6492.772752953653;6325.272593651732;6346.587471814329;6353.682315884211;6364.013577895422;6371.0443433485;5775.884482310351;5787.623804452707;5804.390538993408;5824.796132135376;5905.084711869646;5940.52475801937;5953.196318496991;5959.837831622835;5979.730912108944;6047.546434017444;5859.912101318484;5878.706064696748;5970.492508136814;5973.163757074013;5994.43052909975;5699.800506982236;5775.913361299584;5780.046292361755;5885.47030767233;5887.499562537189;5817.650940943515;5821.62159459638;5864.677442740647;5905.911411328833;5937.821865344046;6348.143000694893;6390.105385246069;6397.744090236385;6414.262359828633;6470.967645161744;6688.498362622823;6693.2302785179845;6721.596704197764;6733.158355205599;6775.085363475917;6773.390394864486;6775.322467753185;6780.220274668427;6854.828629284258;6941.757038503679;6413.647249401328;6447.161868957006;6488.351164883474;6505.316941721098;6510.869782604369;7057.964710176519;7070.045543851617;7083.327083927019;7162.641867906584;7184.6048467334795;6580;6669.46644268467;6712.630805305755;6779.220389655155;6878.55289406187;6802.591844489347;6858.451323894076;6900.309969003059;6901.206361268418;6909.309069093151;6808.489363297773;6914.239433662293;6915.619640919697;6918.100646915868;6932.133483314586;6865.794026179223;6871.759488417882;6948.33990770876;6969.756058537927;6970.198427180939;5247.868803279948;5293.391260005072;5315.681059136464;5341.439148889388;5411.945880541223;4598.632109431237;4604.355390245369;4613.446386433582;4698.060387922429;4776.426828780569;5733.512651424676;5817.825465236049;5830.183774271605;5847.736851841677;5876.912771137353;6827.180738311435;6847.897281540781;6940.785362561633;6952.096227490495;6955.817511023139;5788.594798364074;5803.709814509342;5844.152597873284;5871.236739223874;5875.559333050039;5718.142278658152;5802.129680547867;5804.448577385142;5804.506616937608;5806.477417032487;6558.80323590293;6567.211934567787;6693.832654183684;6702.899456508157;6703.865922681616;6855.451563874978;6920.8961865572055;6944.340287672764;6965.094537710065;6965.33829286217;6580.144581204413;6585.407313341822;6603.20761508622;6682;6684.4318232950745;6664.366885145903;6685.498587605852;6739.696713647995;6761.628110453972;6872.209695885037;6750.493712971449;6853.760118395832;6863.897041544481;6885.414739746977;6885.655717214019;6602.8679426410245;6623.304553022056;6648;6746.055552222595;6747.763828265987;6658.267590565131;6723.495737819585;6761.459083273228;6766.357196066366;6779.694913728993;6570.901436478361;6578.76974305897;6665.733370665119;6674.733010679518;6686.297938716365;6562.5406221564035;6686.69909854048;6691.59850408977;6703.396694297537;6790.830229244309;6421.101045853491;6438.935610644021;6470.741170353322;6471.158749362553;6474.579152355271 15:59:04 INFO - PID 29866 | |1;ext.html;798.6086817459446;868.4572142410993;898.2768871058797;901.6168128545371;1143.6683361825071;29906.40187196255;30368.08895733129;30489.69510304896;39939.800300998526;40123.398149027715;39993.400098998536;40477.392839107364;40502;40562.59437405625;40687.59312406875;7845.882311765328;7917.366610671133;8083.676652933905;8088.595570221495;8093.878591821127;7968.800779980518;8090.110087890327;8112.594370281492;8119;8122.553259570721;8077.232662897045;8120.147384524628;8125.878111828298;8126.146754590772;8150.959245203766;8040.437169398145;8045.195480451966;8059.758207253792;8080.313173380269;8115.9855018122735;7823.960880195563;7890;7950.363970882316;7988;7989.720359787438;36374.454383184275;36455.81772091149;36506.63493365059;36530.26939461196;36600.45099323512;3491.8777842775635;3537.345591065661;3556.466530020492;3557.5730912290433;3571.2678900825526;30242.54636180459;30371.848140759375;30390.84804575963;30695.38609227803;30754.846225768953;5122.3853137623355;5147.639665223436;5160.535551800356;5169.689818610896;5191.32512773337;194497;194759;196466;196706;197347;47268;47352;47447.288290675664;47529.287060694114;47665.76167119142;49254.50745492571;49455.75272123616;49613.50386496161;49752.75123624359;49868;14054.086484378482;14316.141031538142;14329.85670143306;14331.785023224451;14343;11581.247218930743;11600.245984011011;11860.406979650983;13040.80438793419;13258.668533286746;13280.136791108547;13402.396892139877;13454.394552245172;13498.392572334073;13527.256000920044;5402.891942161214;5445.237666726662;5533.944660553423;5557.860223813861;5566.638168519034;996.8205722969935;1016.7508960304773;1021.1983592879554;1027.9743006424749;1032.5818043692316;22067.66898496524;22277.777222227895;22343.55312893733;22689.546209075725;23080.07679692827;1101.553870682375;1106.3748981825242;1112.7759464588887;1112.9109671226283;1124.9268797528134;11932.582359617372;12016.879831201752;12024.819627705592;12077.758444831054;12208.084393670333;235094;236038;236627;236865;237043;51526;51686.48313516892;51820;51960.48039519556;52004.47995520072;1446.5298777897226;1448.2396741710475;1454.338276084379;1456.9417223311161;1461.8318893327191;22206;22425.775742242367;22452.887735561217;22585.5482890338;22703.77296227083;35432.64567354293;35528.64471355253;35578.64421355857;35657;35661.465078023335;195097;195360;195418;196002;196822;31210.687893121685;31455.842720787165;31456;32353.676463235068;34241.65758342385;43642.34536481892;43716.091559626795;43769.562304377825;44200;44344.11311773682;31623.84188079137;31664.366712666077;31998.840005799822;32126.357472849944;32259.35481290314;31889;32113.871769705867;32153.517697235027;32174.678253218106;32414;36204.63795362013;36302.09244768902;36577.26845463129;36597.26805463929;36705.44941825928;30549.389012220076;30980.380392392475;31000.22499437532;31409.52885706762;31521.8423907879;23120.53758924846;23456;24029.639555407033;24091.638625420983;24159.75840241575 15:59:04 INFO - PID 29866 | |2;jquery.html;579.7941730685607;580.3297191743537;594.2838879150623;602.1209034809178;608.89953157729;21772.129114835407;22405.887970560165;22422.327330180102;22500.88749556254;22503.774962250372;22658.54682906345;23832.285031449042;23874.40313992151;24080.51838963224;24115.15596954107;6255.781047663321;6404.935950640481;6418.229812422516;6420.903686444707;6452.9354706452805;6320.367963203666;6393.552451328409;6426.839329016789;6429.2284925808735;6637.535372523926;6592.934070659304;6601.768938087168;6604.537682362236;6605.009248612722;6609.206895172562;6227.968860155715;6537.477001839841;6575.441087507567;6593.109930159439;6599.934000660004;6052.273727152726;6076.210092687967;6086.939130608682;6094.421030002142;6100.96949515254;27164.728352716615;27784.30539236515;27844.582331264846;27851;27881.16356509308;1949.4054313434397;1968.4094771568473;1970.7240986261934;1971.0637447212603;1974.0919177178514;17595.296188152457;18155.636887262182;18289.908550457294;18411.263549458006;18537.629247414978;2437.7805997460314;2451.767082127195;2495.5258500884956;2509.109266210487;2510.3473096994912;123195;129239.35380323132;139679;148528.2573587136;152609;19757.209711611664;20293;20692.586148277253;21536.676949845765;21715.891420543114;40981.385279220834;41566.79216603898;41627;41654.37518437226;41849.58150418457;10846.078083362845;10873.83689244662;10923.235373523778;11011.339319640847;11166.553337866557;9053.049429809907;9108.772280693036;9119.772005699911;9163.49600771964;9224.631014759469;10660.147188224923;10709.839352409721;10753.51609177589;10974.286671366335;11036.503357348938;4007.899802504961;4065.57311482296;4356.891077723082;4470.552944705503;4516.435445569304;965.1892410375178;969.418348990614;982.9017098290113;993.9403635781877;997.2670087485692;18928.43214703561;18961.05194740285;19014.904925475283;19251.711224331648;19365.32221372245;1026.973026973027;1039.6984874386344;1041.7135287795766;1044.7022598559527;1048.5962904281907;10123.356000039788;10173.694789156338;10305.690829275134;10774.138068954464;10830.729231769112;475211;482956;490983;496911;502596;109671;114829.4258528702;116010;117268;117519.41240293744;1027.2655051637964;1061.1987949098382;1064.4039337970762;1136.72718547548;1157.1321508868348;19243.903780481567;19259;19420;19590.90204548968;19597.804021959597;57230.7138464305;57940.420595795185;57999.4200057994;59073.70463147657;59364.70317648384;69408;70107.29892701008;70824;71251.64374178096;71656;18679.626407472046;18930.148143333307;19051.237950481827;19087.52281192926;19314.517137071685;21073.6838947419;21162.68255976131;21288.36134915955;21536.56926861423;21590;17284.222210000833;17354;17557.38549150825;17575.560610984827;17748.112594370486;15081;15811.13038782878;16093.436729714873;16128.193590320672;16368.263428145523;17371.478855634352;17594;17834.46496605104;17857.821421786135;17931.73102403491;18518.351857684916;18673.53316167107;18714;18831.435056948314;18837.623247535248;17123.400680976105;17188.656226875144;17254.827451725323;17324.480265592054;17469.65060698804 15:59:04 INFO - PID 29866 | |3;mootools.html;1313.3039489070793;1370.8492065872747;1386.2375693368645;1395.62318174093;1399.9510017149398;12811.871881281184;13259.535916242934;13279.867201327985;13283.269420181887;13315.800262996063;14748.6312842179;14822.55532334029;14872.405103795834;14875.85124148761;14918.104913705185;2736.808423410362;2867.913962581126;2870.0959197852712;2870.7846911481724;2875.827450352975;2688.7983401244887;2818.8590570471497;2827.915162545117;2829.830210187385;2830.066078194191;2769.778417726577;2870.4833130036586;2875.0368626510144;2875.0943452812403;2877.021812583721;2792.0367473221704;2820.5769134629763;2834.1497550734903;2837.858107094637;2867.670217924934;2693.138195777352;2711.4848178845955;2719.456108778252;2722.8502432366213;2801.0616443491454;14527.92736036313;14636.634084147876;14740.705185896222;14743.557693269218;14764.409423623043;7377.704891804375;7671.347935425496;7698.461107722462;7700.268474494914;7703.730369437043;5182.404023537304;5232.293640358579;5315.973420132875;5350.224217488442;5370.275012873251;1840.55826601616;1841.9631607367912;1849.4544109487733;1880.5298675331167;1889.3576184097335;25629.359266018313;25823.483530329475;26653;26678.333041674112;26696.86651566749;6861.142357205349;6878.140232470942;6992.6853291602;7067.646617669096;7198.5680859148615;17134.57163570896;17180;17198;17242.741358879626;17284.135793210287;7538.057742782153;7732.226777322223;7733.41999350051;7742.6902923883545;7762.41781866351;7080.2919708028785;7101.289871012961;7142.714291428285;7338;7338.192798792129;4982.925256121089;5135.768890399941;5158.509941555546;5158.793648254103;5183.118869792069;1409.2601384273134;1433.5054406230042;1460.2114857976785;1473.4990103364908;1474.6387135151956;899.0829354058955;906.207068814787;915.3135148638521;924.1036194890945;933.0389698610442;7784.3772498200005;7792.649330780128;7842.882356764653;7843.56860372685;7924.960375198202;736.6390468670313;746.7349091072591;746.9701211951569;747.4170147285126;764.4495962906698;4578.816847326069;4655.883602909955;4682.976585117052;4838.516148385203;5527.861803454865;19986.70019949702;20846.791532084484;20994.265200717902;21157.365279041653;21164.94175291229;20478.385648430572;20752;20941.790582094287;20945.895270523855;21390.572188556143;8877.01602836179;9213.30900182489;9639.084286992584;10572.471376431147;10797.946010269898;8095.433319667567;8919.241864441596;8925.509096999467;8945.642174312954;9073.092690730875;18215.45353639393;18332.17505212242;18573.349932752288;18738.531536711693;19005.904970475058;18441.538961525534;18558;18680.813191867906;18697.252109915997;18733.250669973593;10843.132549396187;11049.33703977764;11060.22578419535;11065.336079835235;11091.72270693239;13689.520866769615;13694.794578081137;13729.725405491634;13908.304584770924;13926.721465570834;10196.745081373025;10206.693799186036;10506.21203409732;10545.10366618846;10681.732956676145;10405.895941040493;10480.109190718875;10597.788044239227;10705.571777129138;11037.503312351124;9900.108990190918;10103.393796372242;10113.797724045331;10119.038691324313;10121.493925303852;7624.5425274483705;7629.580373079534;7649.617519124133;7717.961410192913;7850.646720897687;7681.884771728541;7708.730194443167;7708.884366734392;7750.186230445722;7802.024746906637 15:59:04 INFO - PID 29866 | |4;prototype.html;509.98470045898625;521.70002248707;540.7242306423727;541.2638811216744;543.9918401223981;6345.873082538352;6375.234971803378;6376.904346434807;6406;6408.903866442007;6105.877882442349;6211.347808480113;6255.562110652256;6353.570446649502;6353.602207514351;5093.516115968995;5126.7436628168625;5135.64050516464;5140.922886156711;5154.355705536808;5087.66930149541;5117.385913690344;5133.6919784813035;5138.563222126105;5140.588752899759;4950.480199579047;5135.486451354872;5138.794448222066;5152.484751524855;5153.149730294497;5101.336826212606;5115.437301896788;5143.717095559743;5174.818881339153;5184.222366644995;4570.954290457086;4578.954210457886;4602.148602508513;4602.263637817933;4602.976985115053;6117.990531562287;6165.537584681122;6247.281562620311;6272.498200143978;6283.465905398047;5859.4140585941495;5873.2658417697785;5899.115132730082;5914.260717410324;5914.349421563625;6648.570557330149;6689.565178263398;6733.595984240961;6741.258461569223;6757.290484499106;4940.777665005084;4978.551930326288;4987.900241995176;5000.699958002531;5000.89998200034;6986.930130698679;6997.790066298019;7003.754868579626;7045.330693584101;7072.964635176842;5106.591472682177;5194.584433245332;5195.324607801037;5199.766010529535;5213.530782229617;5100.974495127575;5125.769340379692;5149.201873709506;5158.226266060121;5163.715995620202;5737.627054241461;5766.682832444172;5772.249607551075;5815.73829177688;5854.443827836349;6624.27133015368;6789.490788190807;6815.318468153244;6816.284290149562;6834.214065382445;1687.4262750664832;1799.2802878848304;1799.7480352750626;1802.765640466731;1819.6269764698204;1177.3406892140429;1208.293148508115;1237.2329155923385;1256.9371531423392;1283.6983308922395;5672.631278966854;5702.201691763156;5745.482906538432;5759.366469688331;5766.365699773021;6613;6667.133272674619;6725.899111513331;6734.696938637773;6777.559458635173;5623.437656234426;5718.456746609066;5720.256366672306;5747.770089196385;5798.420157984167;3559.323728491578;3603.85584576614;3616.475611036385;3617.963820361815;3657.3599620066384;6489.318621544764;6528.640924749185;6550.246721626979;6569.277379488252;6634.303398143222;6957.686904089328;6988.650567471708;7032.296770323029;7052.33002864727;7058.188308344504;6539.149910511603;6586.670666466657;6612.669366531654;6626.469882409299;6681.832954176184;6758.898616520658;6780.762673306608;6826.761063362758;6847.828804279933;6867.214524223637;6649.4680425564875;6673.499487538551;6731.293214212437;6732.259451460433;6746.291639377991;6368.745250190126;6569.770058047945;6573.605583664996;6589.17635295588;6616;5082.440931497458;5096.261042148942;5126.6923984561045;5132.717700526507;5144.897102058013;6555.180602424697;6723.294054124247;6724.865502689821;6770.15933607473;6789.15135608049;6431.163948686828;6434.903476447764;6528.608283503005;6593.241777195492;6631.502637302318;6394.4564712;6433.903491447539;6454;6552.63960482178;6571.211454625475;6292.280789407944;6401.687654030819;6434.935650643621;6444.13004244421;6499.902501462388;6224.657643829632;6431.453326467303;6608.273089960197;6660.733570657313;6670.466362691071;5881.38245484218;6200.224971878515;6218.502519798315;6384.329645387167;6469.708863101077 15:59:04 INFO - PID 29866 | |5;yui.html;884.0805562215296;898.6674930275798;918.5866360137935;926.4765407544737;929.8093890752397;19284.614307713855;20194.889281089534;20647.483812904647;20661.793382066175;20664.380068597966;18069.1868865901;18690.813091869077;18860.302572768447;19002;19069.237230510764;955.254901177083;962.4706411473696;969.5830792759111;971.6744890461669;972.3388096094653;963.1812958984842;994.1450352696675;994.5474808961905;997.7705127820606;998.8152191844496;1045.5242864496674;1049.4333060147512;1054.5676272728183;1054.8628678271814;1055.5461151704765;1057.6245432871335;1058.4760543530924;1060.782539579392;1060.7984482948293;1061.2624226162782;727.6252729844134;749.5914726474085;759.5556599389308;772.5596410046276;778.9454738168331;20589.79410205894;20683.276085337093;20734.170633174654;20813.479663008395;20814.16743330265;21814.781852181433;22022.11911523537;22399.88800055989;22498.325050248517;22584.20955266558;17531;17730.29078836845;17808.198631061634;17924.91037544817;18036.819631803777;3740.7942563159286;3760.6427389397963;3762.9247415051545;3765.8870233893026;3768.4724138620613;148699;149037.99999999892;149254;149975.25012374867;152206.23896880445;17400;17406.129693515275;17429;17659.470215893543;17697.38059167923;30917.38165236683;30944.535831962537;31150.22124446907;31187.532187017212;31216.21959451032;7654.464187506933;8359.164083591713;8454.239118479367;8557.187067228604;8586.098459661645;4030.496187976503;4107.178564287155;4114.1977314424;4117.197146556393;4127.7936103194725;5544.805931792368;5636.971815140898;5637.436256374412;5652.463016013472;5652.971735141298;1045.0490054050777;1047.4500887034217;1054.4991129213715;1057.370864335719;1062.5696592879897;664.7706541243264;676.4960104722013;677.4715721737053;685.1640997982454;692.0829900382014;11495.885041149482;11767.176297659253;11805.822912656316;12268.509259629693;12400.069994750429;689.1764341611726;691.799378180322;692.3215249055853;706.2584286499156;707.434052757802;5278.313819203479;5419.105847535191;5420.756065977041;5438.83683489496;5456.290682211366;123467;123688;124057.37971310086;124380.37809811074;127665.36167319104;110781;110969.44515277534;113035;114541;117288.41355793166;100810.4959475198;101032;101620.49189754004;102105.48947255216;102128;10009.199264059003;10135.391876487434;10203.84694229602;10306.948465257627;10342.586296548356;44366;44550.55449445464;45367.09265814731;45545;46752.532474674816;57658;57856.4214357851;58286.4171358281;60641.393586063576;61223;14514.419423222953;14904.329305181509;14943.178125203218;14949.476768313492;15028.849711502746;17085.402010929556;17565.912170439577;17718.557036074202;17818.10909454496;17833.554161146076;16969.406070787463;16980.575485612466;17072;17184.914075430042;17287.394941176997;16145.596360090622;16540.66918661644;16592.087435190697;16747.497575072768;16754.91622541928;14853.108813471226;14925.626859328604;15038.323275452412;15202.771958420411;15218.543443696706;11706.88293117058;11739;11761.235519691534;11768.58809941648;12109.455074521844;12468.812967805308;12661.493540258287;12667.30329831868;12713.745725085631;12727.23636581808 15:59:04 INFO - PID 29866 | __end_tp_report 15:59:04 INFO - PID 29866 | __start_cc_report 15:59:04 INFO - PID 29866 | _x_x_mozilla_cycle_collect,259 15:59:04 INFO - PID 29866 | __end_cc_report 15:59:04 INFO - PID 29866 | __startTimestamp1506725944680__endTimestamp 15:59:04 INFO - PID 29866 | 15:59:04 INFO - PID 29866 | ------- Summary: start ------- 15:59:04 INFO - PID 29866 | Number of tests: 6 15:59:04 INFO - PID 29866 | 15:59:04 INFO - PID 29866 | [#0] dojo.html Cycles:165 Average:6292.27 Median:6567.21 stddev:770.17 (11.7%) stddev-sans-first:732.31 15:59:04 INFO - PID 29866 | Values: 3160.7 3193.8 3219.6 3225.5 3227.5 6278.5 6367.7 6438.0 6468.9 6492.8 6325.3 6346.6 6353.7 6364.0 6371.0 5775.9 5787.6 5804.4 5824.8 5905.1 5940.5 5953.2 5959.8 5979.7 6047.5 5859.9 5878.7 5970.5 5973.2 5994.4 5699.8 5775.9 5780.0 5885.5 5887.5 5817.7 5821.6 5864.7 5905.9 5937.8 6348.1 6390.1 6397.7 6414.3 6471.0 6688.5 6693.2 6721.6 6733.2 6775.1 6773.4 6775.3 6780.2 6854.8 6941.8 6413.6 6447.2 6488.4 6505.3 6510.9 7058.0 7070.0 7083.3 7162.6 7184.6 6580.0 6669.5 6712.6 6779.2 6878.6 6802.6 6858.5 6900.3 6901.2 6909.3 6808.5 6914.2 6915.6 6918.1 6932.1 6865.8 6871.8 6948.3 6969.8 6970.2 5247.9 5293.4 5315.7 5341.4 5411.9 4598.6 4604.4 4613.4 4698.1 4776.4 5733.5 5817.8 5830.2 5847.7 5876.9 6827.2 6847.9 6940.8 6952.1 6955.8 5788.6 5803.7 5844.2 5871.2 5875.6 5718.1 5802.1 5804.4 5804.5 5806.5 6558.8 6567.2 6693.8 6702.9 6703.9 6855.5 6920.9 6944.3 6965.1 6965.3 6580.1 6585.4 6603.2 6682.0 6684.4 6664.4 6685.5 6739.7 6761.6 6872.2 6750.5 6853.8 6863.9 6885.4 6885.7 6602.9 6623.3 6648.0 6746.1 6747.8 6658.3 6723.5 6761.5 6766.4 6779.7 6570.9 6578.8 6665.7 6674.7 6686.3 6562.5 6686.7 6691.6 6703.4 6790.8 6421.1 6438.9 6470.7 6471.2 6474.6 15:59:04 INFO - PID 29866 | 15:59:04 INFO - PID 29866 | [#1] ext.html Cycles:180 Average:37262.41 Median:32383.84 stddev:54491.10 (168.3%) stddev-sans-first:54575.18 15:59:04 INFO - PID 29866 | Values: 798.6 868.5 898.3 901.6 1143.7 29906.4 30368.1 30489.7 39939.8 40123.4 39993.4 40477.4 40502.0 40562.6 40687.6 7845.9 7917.4 8083.7 8088.6 8093.9 7968.8 8090.1 8112.6 8119.0 8122.6 8077.2 8120.1 8125.9 8126.1 8151.0 8040.4 8045.2 8059.8 8080.3 8116.0 7824.0 7890.0 7950.4 7988.0 7989.7 36374.5 36455.8 36506.6 36530.3 36600.5 3491.9 3537.3 3556.5 3557.6 3571.3 30242.5 30371.8 30390.8 30695.4 30754.8 5122.4 5147.6 5160.5 5169.7 5191.3 194497.0 194759.0 196466.0 196706.0 197347.0 47268.0 47352.0 47447.3 47529.3 47665.8 49254.5 49455.8 49613.5 49752.8 49868.0 14054.1 14316.1 14329.9 14331.8 14343.0 11581.2 11600.2 11860.4 13040.8 13258.7 13280.1 13402.4 13454.4 13498.4 13527.3 5402.9 5445.2 5533.9 5557.9 5566.6 996.8 1016.8 1021.2 1028.0 1032.6 22067.7 22277.8 22343.6 22689.5 23080.1 1101.6 1106.4 1112.8 1112.9 1124.9 11932.6 12016.9 12024.8 12077.8 12208.1 235094.0 236038.0 236627.0 236865.0 237043.0 51526.0 51686.5 51820.0 51960.5 52004.5 1446.5 1448.2 1454.3 1456.9 1461.8 22206.0 22425.8 22452.9 22585.5 22703.8 35432.6 35528.6 35578.6 35657.0 35661.5 195097.0 195360.0 195418.0 196002.0 196822.0 31210.7 31455.8 31456.0 32353.7 34241.7 43642.3 43716.1 43769.6 44200.0 44344.1 31623.8 31664.4 31998.8 32126.4 32259.4 31889.0 32113.9 32153.5 32174.7 32414.0 36204.6 36302.1 36577.3 36597.3 36705.4 30549.4 30980.4 31000.2 31409.5 31521.8 23120.5 23456.0 24029.6 24091.6 24159.8 15:59:04 INFO - PID 29866 | 15:59:04 INFO - PID 29866 | [#2] jquery.html Cycles:180 Average:35513.45 Median:21412.47 stddev:82486.45 (385.2%) stddev-sans-first:82676.15 15:59:04 INFO - PID 29866 | Values: 579.8 580.3 594.3 602.1 608.9 21772.1 22405.9 22422.3 22500.9 22503.8 22658.5 23832.3 23874.4 24080.5 24115.2 6255.8 6404.9 6418.2 6420.9 6452.9 6320.4 6393.6 6426.8 6429.2 6637.5 6592.9 6601.8 6604.5 6605.0 6609.2 6228.0 6537.5 6575.4 6593.1 6599.9 6052.3 6076.2 6086.9 6094.4 6101.0 27164.7 27784.3 27844.6 27851.0 27881.2 1949.4 1968.4 1970.7 1971.1 1974.1 17595.3 18155.6 18289.9 18411.3 18537.6 2437.8 2451.8 2495.5 2509.1 2510.3 123195.0 129239.4 139679.0 148528.3 152609.0 19757.2 20293.0 20692.6 21536.7 21715.9 40981.4 41566.8 41627.0 41654.4 41849.6 10846.1 10873.8 10923.2 11011.3 11166.6 9053.0 9108.8 9119.8 9163.5 9224.6 10660.1 10709.8 10753.5 10974.3 11036.5 4007.9 4065.6 4356.9 4470.6 4516.4 965.2 969.4 982.9 993.9 997.3 18928.4 18961.1 19014.9 19251.7 19365.3 1027.0 1039.7 1041.7 1044.7 1048.6 10123.4 10173.7 10305.7 10774.1 10830.7 475211.0 482956.0 490983.0 496911.0 502596.0 109671.0 114829.4 116010.0 117268.0 117519.4 1027.3 1061.2 1064.4 1136.7 1157.1 19243.9 19259.0 19420.0 19590.9 19597.8 57230.7 57940.4 57999.4 59073.7 59364.7 69408.0 70107.3 70824.0 71251.6 71656.0 18679.6 18930.1 19051.2 19087.5 19314.5 21073.7 21162.7 21288.4 21536.6 21590.0 17284.2 17354.0 17557.4 17575.6 17748.1 15081.0 15811.1 16093.4 16128.2 16368.3 17371.5 17594.0 17834.5 17857.8 17931.7 18518.4 18673.5 18714.0 18831.4 18837.6 17123.4 17188.7 17254.8 17324.5 17469.7 15:59:04 INFO - PID 29866 | 15:59:04 INFO - PID 29866 | [#3] mootools.html Cycles:180 Average:9116.36 Median:2729.83 stddev:6480.99 (237.4%) stddev-sans-first:6472.65 15:59:04 INFO - PID 29866 | Values: 1313.3 1370.8 1386.2 1395.6 1400.0 12811.9 13259.5 13279.9 13283.3 13315.8 14748.6 14822.6 14872.4 14875.9 14918.1 2736.8 2867.9 2870.1 2870.8 2875.8 2688.8 2818.9 2827.9 2829.8 2830.1 2769.8 2870.5 2875.0 2875.1 2877.0 2792.0 2820.6 2834.1 2837.9 2867.7 2693.1 2711.5 2719.5 2722.9 2801.1 14527.9 14636.6 14740.7 14743.6 14764.4 7377.7 7671.3 7698.5 7700.3 7703.7 5182.4 5232.3 5316.0 5350.2 5370.3 1840.6 1842.0 1849.5 1880.5 1889.4 25629.4 25823.5 26653.0 26678.3 26696.9 6861.1 6878.1 6992.7 7067.6 7198.6 17134.6 17180.0 17198.0 17242.7 17284.1 7538.1 7732.2 7733.4 7742.7 7762.4 7080.3 7101.3 7142.7 7338.0 7338.2 4982.9 5135.8 5158.5 5158.8 5183.1 1409.3 1433.5 1460.2 1473.5 1474.6 899.1 906.2 915.3 924.1 933.0 7784.4 7792.6 7842.9 7843.6 7925.0 736.6 746.7 747.0 747.4 764.4 4578.8 4655.9 4683.0 4838.5 5527.9 19986.7 20846.8 20994.3 21157.4 21164.9 20478.4 20752.0 20941.8 20945.9 21390.6 8877.0 9213.3 9639.1 10572.5 10797.9 8095.4 8919.2 8925.5 8945.6 9073.1 18215.5 18332.2 18573.3 18738.5 19005.9 18441.5 18558.0 18680.8 18697.3 18733.3 10843.1 11049.3 11060.2 11065.3 11091.7 13689.5 13694.8 13729.7 13908.3 13926.7 10196.7 10206.7 10506.2 10545.1 10681.7 10405.9 10480.1 10597.8 10705.6 11037.5 9900.1 10103.4 10113.8 10119.0 10121.5 7624.5 7629.6 7649.6 7718.0 7850.6 7681.9 7708.7 7708.9 7750.2 7802.0 15:59:04 INFO - PID 29866 | 15:59:04 INFO - PID 29866 | [#4] prototype.html Cycles:180 Average:5583.48 Median:6214.93 stddev:1550.92 (25.0%) stddev-sans-first:1507.80 15:59:04 INFO - PID 29866 | Values: 510.0 521.7 540.7 541.3 544.0 6345.9 6375.2 6376.9 6406.0 6408.9 6105.9 6211.3 6255.6 6353.6 6353.6 5093.5 5126.7 5135.6 5140.9 5154.4 5087.7 5117.4 5133.7 5138.6 5140.6 4950.5 5135.5 5138.8 5152.5 5153.1 5101.3 5115.4 5143.7 5174.8 5184.2 4571.0 4579.0 4602.1 4602.3 4603.0 6118.0 6165.5 6247.3 6272.5 6283.5 5859.4 5873.3 5899.1 5914.3 5914.3 6648.6 6689.6 6733.6 6741.3 6757.3 4940.8 4978.6 4987.9 5000.7 5000.9 6986.9 6997.8 7003.8 7045.3 7073.0 5106.6 5194.6 5195.3 5199.8 5213.5 5101.0 5125.8 5149.2 5158.2 5163.7 5737.6 5766.7 5772.2 5815.7 5854.4 6624.3 6789.5 6815.3 6816.3 6834.2 1687.4 1799.3 1799.7 1802.8 1819.6 1177.3 1208.3 1237.2 1256.9 1283.7 5672.6 5702.2 5745.5 5759.4 5766.4 6613.0 6667.1 6725.9 6734.7 6777.6 5623.4 5718.5 5720.3 5747.8 5798.4 3559.3 3603.9 3616.5 3618.0 3657.4 6489.3 6528.6 6550.2 6569.3 6634.3 6957.7 6988.7 7032.3 7052.3 7058.2 6539.1 6586.7 6612.7 6626.5 6681.8 6758.9 6780.8 6826.8 6847.8 6867.2 6649.5 6673.5 6731.3 6732.3 6746.3 6368.7 6569.8 6573.6 6589.2 6616.0 5082.4 5096.3 5126.7 5132.7 5144.9 6555.2 6723.3 6724.9 6770.2 6789.2 6431.2 6434.9 6528.6 6593.2 6631.5 6394.5 6433.9 6454.0 6552.6 6571.2 6292.3 6401.7 6434.9 6444.1 6499.9 6224.7 6431.5 6608.3 6660.7 6670.5 5881.4 6200.2 6218.5 6384.3 6469.7 15:59:04 INFO - PID 29866 | 15:59:04 INFO - PID 29866 | [#5] yui.html Cycles:180 Average:25149.67 Median:18380.00 stddev:37091.18 (201.8%) stddev-sans-first:37150.48 15:59:04 INFO - PID 29866 | Values: 884.1 898.7 918.6 926.5 929.8 19284.6 20194.9 20647.5 20661.8 20664.4 18069.2 18690.8 18860.3 19002.0 19069.2 955.3 962.5 969.6 971.7 972.3 963.2 994.1 994.5 997.8 998.8 1045.5 1049.4 1054.6 1054.9 1055.5 1057.6 1058.5 1060.8 1060.8 1061.3 727.6 749.6 759.6 772.6 778.9 20589.8 20683.3 20734.2 20813.5 20814.2 21814.8 22022.1 22399.9 22498.3 22584.2 17531.0 17730.3 17808.2 17924.9 18036.8 3740.8 3760.6 3762.9 3765.9 3768.5 148699.0 149038.0 149254.0 149975.3 152206.2 17400.0 17406.1 17429.0 17659.5 17697.4 30917.4 30944.5 31150.2 31187.5 31216.2 7654.5 8359.2 8454.2 8557.2 8586.1 4030.5 4107.2 4114.2 4117.2 4127.8 5544.8 5637.0 5637.4 5652.5 5653.0 1045.0 1047.5 1054.5 1057.4 1062.6 664.8 676.5 677.5 685.2 692.1 11495.9 11767.2 11805.8 12268.5 12400.1 689.2 691.8 692.3 706.3 707.4 5278.3 5419.1 5420.8 5438.8 5456.3 123467.0 123688.0 124057.4 124380.4 127665.4 110781.0 110969.4 113035.0 114541.0 117288.4 100810.5 101032.0 101620.5 102105.5 102128.0 10009.2 10135.4 10203.8 10306.9 10342.6 44366.0 44550.6 45367.1 45545.0 46752.5 57658.0 57856.4 58286.4 60641.4 61223.0 14514.4 14904.3 14943.2 14949.5 15028.8 17085.4 17565.9 17718.6 17818.1 17833.6 16969.4 16980.6 17072.0 17184.9 17287.4 16145.6 16540.7 16592.1 16747.5 16754.9 14853.1 14925.6 15038.3 15202.8 15218.5 11706.9 11739.0 11761.2 11768.6 12109.5 12468.8 12661.5 12667.3 12713.7 12727.2 15:59:04 INFO - PID 29866 | -------- Summary: end -------- 15:59:04 INFO - PID 29866 | 15:59:05 INFO - TEST-INFO | 29866: exit 0 15:59:05 INFO - TEST-OK | dromaeo_css | took 1109477ms 15:59:05 INFO - TEST-START | kraken 15:59:05 INFO - Initialising browser for kraken test... 15:59:05 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54893/getInfo.html -profile /tmp/tmpGkLQZ0/profile 15:59:05 INFO - TEST-INFO | started process 30229 (/builds/slave/test/build/application/firefox/firefox http://localhost:54893/getInfo.html) 15:59:10 INFO - TEST-INFO | 30229: exit 0 15:59:10 INFO - Browser initialized. 15:59:10 INFO - Running cycle 1/1 for kraken test... 15:59:10 INFO - Using env: {'DISPLAY': ':0', 15:59:10 INFO - 'HOME': '/home/cltbld', 15:59:10 INFO - 'JSGC_DISABLE_POISONING': '1', 15:59:10 INFO - 'LANG': 'en_US.UTF-8', 15:59:10 INFO - 'LANGUAGE': 'en_US:en', 15:59:10 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:59:10 INFO - 'LOGNAME': 'cltbld', 15:59:10 INFO - 'MAIL': '/var/mail/cltbld', 15:59:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:59:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:59:10 INFO - 'MOZ_CRASHREPORTER': '1', 15:59:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:10 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:59:10 INFO - 'MOZ_NO_REMOTE': '1', 15:59:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:59:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:10 INFO - 'NO_EM_RESTART': '1', 15:59:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:10 INFO - 'PWD': '/builds/slave/test', 15:59:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:59:10 INFO - 'RUST_BACKTRACE': 'full', 15:59:10 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:59:10 INFO - 'SHELL': '/bin/bash', 15:59:10 INFO - 'SHLVL': '1', 15:59:10 INFO - 'TERM': 'linux', 15:59:10 INFO - 'TMOUT': '86400', 15:59:10 INFO - 'USER': 'cltbld', 15:59:10 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506723941.230278-256094443', 15:59:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:10 INFO - '_': '/tools/buildbot/bin/python'} 15:59:10 INFO - TEST-INFO | started process 30469 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGkLQZ0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:59:11 INFO - PID 30469 | 15:59:11 INFO - PID 30469 | (/builds/slave/test/build/application/firefox/firefox:30518): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:59:11 INFO - PID 30469 | 15:59:21 INFO - PID 30469 | RSS: Main: 151871488 15:59:21 INFO - PID 30469 | 15:59:24 INFO - PID 30469 | Cycle 1(1): loaded http://localhost:54893/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54893/tests/kraken/driver.html?testName=audio-beat-detection) 15:59:25 INFO - PID 30469 | RSS: Main: 157364224 15:59:25 INFO - PID 30469 | 15:59:28 INFO - PID 30469 | Cycle 1(1): loaded http://localhost:54893/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54893/tests/kraken/driver.html?testName=audio-dft) 15:59:28 INFO - PID 30469 | RSS: Main: 158035968 15:59:28 INFO - PID 30469 | 15:59:31 INFO - PID 30469 | Cycle 1(1): loaded http://localhost:54893/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54893/tests/kraken/driver.html?testName=audio-fft) 15:59:32 INFO - PID 30469 | RSS: Main: 155525120 15:59:32 INFO - PID 30469 | 15:59:34 INFO - PID 30469 | Cycle 1(1): loaded http://localhost:54893/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54893/tests/kraken/driver.html?testName=audio-oscillator) 15:59:35 INFO - PID 30469 | RSS: Main: 155353088 15:59:35 INFO - PID 30469 | 15:59:37 INFO - PID 30469 | Cycle 1(1): loaded http://localhost:54893/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54893/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:59:37 INFO - PID 30469 | RSS: Main: 155656192 15:59:37 INFO - PID 30469 | 15:59:40 INFO - PID 30469 | Cycle 1(1): loaded http://localhost:54893/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54893/tests/kraken/driver.html?testName=imaging-darkroom) 15:59:41 INFO - PID 30469 | RSS: Main: 157753344 15:59:41 INFO - PID 30469 | 15:59:45 INFO - PID 30469 | Cycle 1(1): loaded http://localhost:54893/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54893/tests/kraken/driver.html?testName=imaging-desaturate) 15:59:45 INFO - PID 30469 | RSS: Main: 157491200 15:59:45 INFO - PID 30469 | 15:59:48 INFO - PID 30469 | Cycle 1(1): loaded http://localhost:54893/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54893/tests/kraken/driver.html?testName=json-parse-financial) 15:59:49 INFO - PID 30469 | RSS: Main: 158556160 15:59:49 INFO - PID 30469 | 15:59:51 INFO - PID 30469 | Cycle 1(1): loaded http://localhost:54893/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54893/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:59:51 INFO - PID 30469 | RSS: Main: 157896704 15:59:51 INFO - PID 30469 | 15:59:53 INFO - PID 30469 | Cycle 1(1): loaded http://localhost:54893/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54893/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:59:53 INFO - PID 30469 | RSS: Main: 158035968 15:59:53 INFO - PID 30469 | 15:59:55 INFO - PID 30469 | Cycle 1(1): loaded http://localhost:54893/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54893/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:59:56 INFO - PID 30469 | RSS: Main: 155258880 15:59:56 INFO - PID 30469 | 15:59:59 INFO - PID 30469 | Cycle 1(1): loaded http://localhost:54893/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54893/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:59:59 INFO - PID 30469 | RSS: Main: 155402240 15:59:59 INFO - PID 30469 | 16:00:02 INFO - PID 30469 | Cycle 1(1): loaded http://localhost:54893/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54893/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:00:03 INFO - PID 30469 | RSS: Main: 155521024 16:00:03 INFO - PID 30469 | 16:00:05 INFO - PID 30469 | Cycle 1(1): loaded http://localhost:54893/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54893/tests/kraken/driver.html?testName=ai-astar) 16:00:05 INFO - PID 30469 | RSS: Main: 157065216 16:00:05 INFO - PID 30469 | 16:00:05 INFO - PID 30469 | __start_tp_report 16:00:05 INFO - PID 30469 | _x_x_mozilla_page_load 16:00:05 INFO - PID 30469 | _x_x_mozilla_page_load_details 16:00:05 INFO - PID 30469 | |i|pagename|runs| 16:00:05 INFO - PID 30469 | |0;ai-astar;108;108;107;107;109;107;107;106;106;108 16:00:05 INFO - PID 30469 | |1;audio-beat-detection;117;119;119;115;117;118;115;116;123;120 16:00:05 INFO - PID 30469 | |2;audio-dft;165;163;165;162;164;163;164;164;171;170 16:00:05 INFO - PID 30469 | |3;audio-fft;75;75;76;75;74;73;77;75;75;75 16:00:05 INFO - PID 30469 | |4;audio-oscillator;80;79;79;78;78;79;79;80;84;80 16:00:05 INFO - PID 30469 | |5;imaging-gaussian-blur;129;111;111;112;112;112;113;112;112;112 16:00:05 INFO - PID 30469 | |6;imaging-darkroom;148;147;148;148;149;147;148;149;147;148 16:00:05 INFO - PID 30469 | |7;imaging-desaturate;94;94;94;98;95;95;94;94;94;94 16:00:05 INFO - PID 30469 | |8;json-parse-financial;57;53;55;55;51;51;52;52;53;51 16:00:05 INFO - PID 30469 | |9;json-stringify-tinderbox;37;38;37;37;37;37;37;37;37;37 16:00:05 INFO - PID 30469 | |10;stanford-crypto-aes;78;74;74;75;76;74;77;76;73;73 16:00:05 INFO - PID 30469 | |11;stanford-crypto-ccm;110;115;108;112;111;115;111;112;116;113 16:00:05 INFO - PID 30469 | |12;stanford-crypto-pbkdf2;161;172;171;161;167;159;162;167;158;158 16:00:05 INFO - PID 30469 | |13;stanford-crypto-sha256-iterative;66;63;63;68;64;66;67;63;71;73 16:00:05 INFO - PID 30469 | __end_tp_report 16:00:05 INFO - PID 30469 | __start_cc_report 16:00:05 INFO - PID 30469 | _x_x_mozilla_cycle_collect,733 16:00:05 INFO - PID 30469 | __end_cc_report 16:00:05 INFO - PID 30469 | __startTimestamp1506726005325__endTimestamp 16:00:05 INFO - PID 30469 | 16:00:05 INFO - PID 30469 | ------- Summary: start ------- 16:00:05 INFO - PID 30469 | Number of tests: 14 16:00:05 INFO - PID 30469 | 16:00:05 INFO - PID 30469 | [#0] ai-astar Cycles:10 Average:107.30 Median:107.50 stddev:0.95 (0.9%) stddev-sans-first:0.97 16:00:05 INFO - PID 30469 | Values: 108.0 108.0 107.0 107.0 109.0 107.0 107.0 106.0 106.0 108.0 16:00:05 INFO - PID 30469 | 16:00:05 INFO - PID 30469 | [#1] audio-beat-detection Cycles:10 Average:117.90 Median:118.50 stddev:2.47 (2.1%) stddev-sans-first:2.60 16:00:05 INFO - PID 30469 | Values: 117.0 119.0 119.0 115.0 117.0 118.0 115.0 116.0 123.0 120.0 16:00:05 INFO - PID 30469 | 16:00:05 INFO - PID 30469 | [#2] audio-dft Cycles:10 Average:165.10 Median:164.50 stddev:3.00 (1.8%) stddev-sans-first:3.18 16:00:05 INFO - PID 30469 | Values: 165.0 163.0 165.0 162.0 164.0 163.0 164.0 164.0 171.0 170.0 16:00:05 INFO - PID 30469 | 16:00:05 INFO - PID 30469 | [#3] audio-fft Cycles:10 Average:75.00 Median:75.00 stddev:1.05 (1.4%) stddev-sans-first:1.12 16:00:05 INFO - PID 30469 | Values: 75.0 75.0 76.0 75.0 74.0 73.0 77.0 75.0 75.0 75.0 16:00:05 INFO - PID 30469 | 16:00:05 INFO - PID 30469 | [#4] audio-oscillator Cycles:10 Average:79.60 Median:79.50 stddev:1.71 (2.2%) stddev-sans-first:1.81 16:00:05 INFO - PID 30469 | Values: 80.0 79.0 79.0 78.0 78.0 79.0 79.0 80.0 84.0 80.0 16:00:05 INFO - PID 30469 | 16:00:05 INFO - PID 30469 | [#5] imaging-gaussian-blur Cycles:10 Average:113.60 Median:112.00 stddev:5.44 (4.9%) stddev-sans-first:0.60 16:00:05 INFO - PID 30469 | Values: 129.0 111.0 111.0 112.0 112.0 112.0 113.0 112.0 112.0 112.0 16:00:05 INFO - PID 30469 | 16:00:05 INFO - PID 30469 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 16:00:05 INFO - PID 30469 | Values: 148.0 147.0 148.0 148.0 149.0 147.0 148.0 149.0 147.0 148.0 16:00:05 INFO - PID 30469 | 16:00:05 INFO - PID 30469 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:94.00 stddev:1.26 (1.3%) stddev-sans-first:1.32 16:00:05 INFO - PID 30469 | Values: 94.0 94.0 94.0 98.0 95.0 95.0 94.0 94.0 94.0 94.0 16:00:05 INFO - PID 30469 | 16:00:05 INFO - PID 30469 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:53.00 stddev:2.05 (3.9%) stddev-sans-first:1.59 16:00:05 INFO - PID 30469 | Values: 57.0 53.0 55.0 55.0 51.0 51.0 52.0 52.0 53.0 51.0 16:00:05 INFO - PID 30469 | 16:00:05 INFO - PID 30469 | [#9] json-stringify-tinderbox Cycles:10 Average:37.10 Median:37.00 stddev:0.32 (0.9%) stddev-sans-first:0.33 16:00:05 INFO - PID 30469 | Values: 37.0 38.0 37.0 37.0 37.0 37.0 37.0 37.0 37.0 37.0 16:00:05 INFO - PID 30469 | 16:00:05 INFO - PID 30469 | [#10] stanford-crypto-aes Cycles:10 Average:75.00 Median:75.50 stddev:1.70 (2.3%) stddev-sans-first:1.41 16:00:05 INFO - PID 30469 | Values: 78.0 74.0 74.0 75.0 76.0 74.0 77.0 76.0 73.0 73.0 16:00:05 INFO - PID 30469 | 16:00:05 INFO - PID 30469 | [#11] stanford-crypto-ccm Cycles:10 Average:112.30 Median:112.50 stddev:2.50 (2.2%) stddev-sans-first:2.51 16:00:05 INFO - PID 30469 | Values: 110.0 115.0 108.0 112.0 111.0 115.0 111.0 112.0 116.0 113.0 16:00:05 INFO - PID 30469 | 16:00:05 INFO - PID 30469 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.60 Median:164.50 stddev:5.25 (3.2%) stddev-sans-first:5.49 16:00:05 INFO - PID 30469 | Values: 161.0 172.0 171.0 161.0 167.0 159.0 162.0 167.0 158.0 158.0 16:00:05 INFO - PID 30469 | 16:00:05 INFO - PID 30469 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.50 stddev:3.47 (5.2%) stddev-sans-first:3.68 16:00:05 INFO - PID 30469 | Values: 66.0 63.0 63.0 68.0 64.0 66.0 67.0 63.0 71.0 73.0 16:00:05 INFO - PID 30469 | -------- Summary: end -------- 16:00:05 INFO - PID 30469 | 16:00:05 INFO - PID 30469 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:00:05 INFO - TEST-INFO | 30469: exit 0 16:00:06 INFO - TEST-OK | kraken | took 60759ms 16:00:06 INFO - SUITE-END | took 1170s 16:00:06 INFO - Completed test suite (00:19:30) 16:00:06 INFO - javascript benchmark 16:00:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8587.496537760413, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3160.7313378362837, 3193.8083714977097, 3219.613646362437, 3225.483922572389, 3227.5158726191084, 6278.529110316722, 6367.6816159192085, 6437.967810160949, 6468.867948109074, 6492.772752953653, 6325.272593651732, 6346.587471814329, 6353.682315884211, 6364.013577895422, 6371.0443433485, 5775.884482310351, 5787.623804452707, 5804.390538993408, 5824.796132135376, 5905.084711869646, 5940.52475801937, 5953.196318496991, 5959.837831622835, 5979.730912108944, 6047.546434017444, 5859.912101318484, 5878.706064696748, 5970.492508136814, 5973.163757074013, 5994.43052909975, 5699.800506982236, 5775.913361299584, 5780.046292361755, 5885.47030767233, 5887.499562537189, 5817.650940943515, 5821.62159459638, 5864.677442740647, 5905.911411328833, 5937.821865344046, 6348.143000694893, 6390.105385246069, 6397.744090236385, 6414.262359828633, 6470.967645161744, 6688.498362622823, 6693.2302785179845, 6721.596704197764, 6733.158355205599, 6775.085363475917, 6773.390394864486, 6775.322467753185, 6780.220274668427, 6854.828629284258, 6941.757038503679, 6413.647249401328, 6447.161868957006, 6488.351164883474, 6505.316941721098, 6510.869782604369, 7057.964710176519, 7070.045543851617, 7083.327083927019, 7162.641867906584, 7184.6048467334795, 6580.0, 6669.46644268467, 6712.630805305755, 6779.220389655155, 6878.55289406187, 6802.591844489347, 6858.451323894076, 6900.309969003059, 6901.206361268418, 6909.309069093151, 6808.489363297773, 6914.239433662293, 6915.619640919697, 6918.100646915868, 6932.133483314586, 6865.794026179223, 6871.759488417882, 6948.33990770876, 6969.756058537927, 6970.198427180939, 5247.868803279948, 5293.391260005072, 5315.681059136464, 5341.439148889388, 5411.945880541223, 4598.632109431237, 4604.355390245369, 4613.446386433582, 4698.060387922429, 4776.426828780569, 5733.512651424676, 5817.825465236049, 5830.183774271605, 5847.736851841677, 5876.912771137353, 6827.180738311435, 6847.897281540781, 6940.785362561633, 6952.096227490495, 6955.817511023139, 5788.594798364074, 5803.709814509342, 5844.152597873284, 5871.236739223874, 5875.559333050039, 5718.142278658152, 5802.129680547867, 5804.448577385142, 5804.506616937608, 5806.477417032487, 6558.80323590293, 6567.211934567787, 6693.832654183684, 6702.899456508157, 6703.865922681616, 6855.451563874978, 6920.8961865572055, 6944.340287672764, 6965.094537710065, 6965.33829286217, 6580.144581204413, 6585.407313341822, 6603.20761508622, 6682.0, 6684.4318232950745, 6664.366885145903, 6685.498587605852, 6739.696713647995, 6761.628110453972, 6872.209695885037, 6750.493712971449, 6853.760118395832, 6863.897041544481, 6885.414739746977, 6885.655717214019, 6602.8679426410245, 6623.304553022056, 6648.0, 6746.055552222595, 6747.763828265987, 6658.267590565131, 6723.495737819585, 6761.459083273228, 6766.357196066366, 6779.694913728993, 6570.901436478361, 6578.76974305897, 6665.733370665119, 6674.733010679518, 6686.297938716365, 6562.5406221564035, 6686.69909854048, 6691.59850408977, 6703.396694297537, 6790.830229244309, 6421.101045853491, 6438.935610644021, 6470.741170353322, 6471.158749362553, 6474.579152355271], "value": 6232.609759944293, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [798.6086817459446, 868.4572142410993, 898.2768871058797, 901.6168128545371, 1143.6683361825071, 29906.40187196255, 30368.08895733129, 30489.69510304896, 39939.800300998526, 40123.398149027715, 39993.400098998536, 40477.392839107364, 40502.0, 40562.59437405625, 40687.59312406875, 7845.882311765328, 7917.366610671133, 8083.676652933905, 8088.595570221495, 8093.878591821127, 7968.800779980518, 8090.110087890327, 8112.594370281492, 8119.0, 8122.553259570721, 8077.232662897045, 8120.147384524628, 8125.878111828298, 8126.146754590772, 8150.959245203766, 8040.437169398145, 8045.195480451966, 8059.758207253792, 8080.313173380269, 8115.9855018122735, 7823.960880195563, 7890.0, 7950.363970882316, 7988.0, 7989.720359787438, 36374.454383184275, 36455.81772091149, 36506.63493365059, 36530.26939461196, 36600.45099323512, 3491.8777842775635, 3537.345591065661, 3556.466530020492, 3557.5730912290433, 3571.2678900825526, 30242.54636180459, 30371.848140759375, 30390.84804575963, 30695.38609227803, 30754.846225768953, 5122.3853137623355, 5147.639665223436, 5160.535551800356, 5169.689818610896, 5191.32512773337, 194497.0, 194759.0, 196466.0, 196706.0, 197347.0, 47268.0, 47352.0, 47447.288290675664, 47529.287060694114, 47665.76167119142, 49254.50745492571, 49455.75272123616, 49613.50386496161, 49752.75123624359, 49868.0, 14054.086484378482, 14316.141031538142, 14329.85670143306, 14331.785023224451, 14343.0, 11581.247218930743, 11600.245984011011, 11860.406979650983, 13040.80438793419, 13258.668533286746, 13280.136791108547, 13402.396892139877, 13454.394552245172, 13498.392572334073, 13527.256000920044, 5402.891942161214, 5445.237666726662, 5533.944660553423, 5557.860223813861, 5566.638168519034, 996.8205722969935, 1016.7508960304773, 1021.1983592879554, 1027.9743006424749, 1032.5818043692316, 22067.66898496524, 22277.777222227895, 22343.55312893733, 22689.546209075725, 23080.07679692827, 1101.553870682375, 1106.3748981825242, 1112.7759464588887, 1112.9109671226283, 1124.9268797528134, 11932.582359617372, 12016.879831201752, 12024.819627705592, 12077.758444831054, 12208.084393670333, 235094.0, 236038.0, 236627.0, 236865.0, 237043.0, 51526.0, 51686.48313516892, 51820.0, 51960.48039519556, 52004.47995520072, 1446.5298777897226, 1448.2396741710475, 1454.338276084379, 1456.9417223311161, 1461.8318893327191, 22206.0, 22425.775742242367, 22452.887735561217, 22585.5482890338, 22703.77296227083, 35432.64567354293, 35528.64471355253, 35578.64421355857, 35657.0, 35661.465078023335, 195097.0, 195360.0, 195418.0, 196002.0, 196822.0, 31210.687893121685, 31455.842720787165, 31456.0, 32353.676463235068, 34241.65758342385, 43642.34536481892, 43716.091559626795, 43769.562304377825, 44200.0, 44344.11311773682, 31623.84188079137, 31664.366712666077, 31998.840005799822, 32126.357472849944, 32259.35481290314, 31889.0, 32113.871769705867, 32153.517697235027, 32174.678253218106, 32414.0, 36204.63795362013, 36302.09244768902, 36577.26845463129, 36597.26805463929, 36705.44941825928, 30549.389012220076, 30980.380392392475, 31000.22499437532, 31409.52885706762, 31521.8423907879, 23120.53758924846, 23456.0, 24029.639555407033, 24091.638625420983, 24159.75840241575], "value": 16940.61641399466, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.7941730685607, 580.3297191743537, 594.2838879150623, 602.1209034809178, 608.89953157729, 21772.129114835407, 22405.887970560165, 22422.327330180102, 22500.88749556254, 22503.774962250372, 22658.54682906345, 23832.285031449042, 23874.40313992151, 24080.51838963224, 24115.15596954107, 6255.781047663321, 6404.935950640481, 6418.229812422516, 6420.903686444707, 6452.9354706452805, 6320.367963203666, 6393.552451328409, 6426.839329016789, 6429.2284925808735, 6637.535372523926, 6592.934070659304, 6601.768938087168, 6604.537682362236, 6605.009248612722, 6609.206895172562, 6227.968860155715, 6537.477001839841, 6575.441087507567, 6593.109930159439, 6599.934000660004, 6052.273727152726, 6076.210092687967, 6086.939130608682, 6094.421030002142, 6100.96949515254, 27164.728352716615, 27784.30539236515, 27844.582331264846, 27851.0, 27881.16356509308, 1949.4054313434397, 1968.4094771568473, 1970.7240986261934, 1971.0637447212603, 1974.0919177178514, 17595.296188152457, 18155.636887262182, 18289.908550457294, 18411.263549458006, 18537.629247414978, 2437.7805997460314, 2451.767082127195, 2495.5258500884956, 2509.109266210487, 2510.3473096994912, 123195.0, 129239.35380323132, 139679.0, 148528.2573587136, 152609.0, 19757.209711611664, 20293.0, 20692.586148277253, 21536.676949845765, 21715.891420543114, 40981.385279220834, 41566.79216603898, 41627.0, 41654.37518437226, 41849.58150418457, 10846.078083362845, 10873.83689244662, 10923.235373523778, 11011.339319640847, 11166.553337866557, 9053.049429809907, 9108.772280693036, 9119.772005699911, 9163.49600771964, 9224.631014759469, 10660.147188224923, 10709.839352409721, 10753.51609177589, 10974.286671366335, 11036.503357348938, 4007.899802504961, 4065.57311482296, 4356.891077723082, 4470.552944705503, 4516.435445569304, 965.1892410375178, 969.418348990614, 982.9017098290113, 993.9403635781877, 997.2670087485692, 18928.43214703561, 18961.05194740285, 19014.904925475283, 19251.711224331648, 19365.32221372245, 1026.973026973027, 1039.6984874386344, 1041.7135287795766, 1044.7022598559527, 1048.5962904281907, 10123.356000039788, 10173.694789156338, 10305.690829275134, 10774.138068954464, 10830.729231769112, 475211.0, 482956.0, 490983.0, 496911.0, 502596.0, 109671.0, 114829.4258528702, 116010.0, 117268.0, 117519.41240293744, 1027.2655051637964, 1061.1987949098382, 1064.4039337970762, 1136.72718547548, 1157.1321508868348, 19243.903780481567, 19259.0, 19420.0, 19590.90204548968, 19597.804021959597, 57230.7138464305, 57940.420595795185, 57999.4200057994, 59073.70463147657, 59364.70317648384, 69408.0, 70107.29892701008, 70824.0, 71251.64374178096, 71656.0, 18679.626407472046, 18930.148143333307, 19051.237950481827, 19087.52281192926, 19314.517137071685, 21073.6838947419, 21162.68255976131, 21288.36134915955, 21536.56926861423, 21590.0, 17284.222210000833, 17354.0, 17557.38549150825, 17575.560610984827, 17748.112594370486, 15081.0, 15811.13038782878, 16093.436729714873, 16128.193590320672, 16368.263428145523, 17371.478855634352, 17594.0, 17834.46496605104, 17857.821421786135, 17931.73102403491, 18518.351857684916, 18673.53316167107, 18714.0, 18831.435056948314, 18837.623247535248, 17123.400680976105, 17188.656226875144, 17254.827451725323, 17324.480265592054, 17469.65060698804], "value": 12491.076335393287, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1313.3039489070793, 1370.8492065872747, 1386.2375693368645, 1395.62318174093, 1399.9510017149398, 12811.871881281184, 13259.535916242934, 13279.867201327985, 13283.269420181887, 13315.800262996063, 14748.6312842179, 14822.55532334029, 14872.405103795834, 14875.85124148761, 14918.104913705185, 2736.808423410362, 2867.913962581126, 2870.0959197852712, 2870.7846911481724, 2875.827450352975, 2688.7983401244887, 2818.8590570471497, 2827.915162545117, 2829.830210187385, 2830.066078194191, 2769.778417726577, 2870.4833130036586, 2875.0368626510144, 2875.0943452812403, 2877.021812583721, 2792.0367473221704, 2820.5769134629763, 2834.1497550734903, 2837.858107094637, 2867.670217924934, 2693.138195777352, 2711.4848178845955, 2719.456108778252, 2722.8502432366213, 2801.0616443491454, 14527.92736036313, 14636.634084147876, 14740.705185896222, 14743.557693269218, 14764.409423623043, 7377.704891804375, 7671.347935425496, 7698.461107722462, 7700.268474494914, 7703.730369437043, 5182.404023537304, 5232.293640358579, 5315.973420132875, 5350.224217488442, 5370.275012873251, 1840.55826601616, 1841.9631607367912, 1849.4544109487733, 1880.5298675331167, 1889.3576184097335, 25629.359266018313, 25823.483530329475, 26653.0, 26678.333041674112, 26696.86651566749, 6861.142357205349, 6878.140232470942, 6992.6853291602, 7067.646617669096, 7198.5680859148615, 17134.57163570896, 17180.0, 17198.0, 17242.741358879626, 17284.135793210287, 7538.057742782153, 7732.226777322223, 7733.41999350051, 7742.6902923883545, 7762.41781866351, 7080.2919708028785, 7101.289871012961, 7142.714291428285, 7338.0, 7338.192798792129, 4982.925256121089, 5135.768890399941, 5158.509941555546, 5158.793648254103, 5183.118869792069, 1409.2601384273134, 1433.5054406230042, 1460.2114857976785, 1473.4990103364908, 1474.6387135151956, 899.0829354058955, 906.207068814787, 915.3135148638521, 924.1036194890945, 933.0389698610442, 7784.3772498200005, 7792.649330780128, 7842.882356764653, 7843.56860372685, 7924.960375198202, 736.6390468670313, 746.7349091072591, 746.9701211951569, 747.4170147285126, 764.4495962906698, 4578.816847326069, 4655.883602909955, 4682.976585117052, 4838.516148385203, 5527.861803454865, 19986.70019949702, 20846.791532084484, 20994.265200717902, 21157.365279041653, 21164.94175291229, 20478.385648430572, 20752.0, 20941.790582094287, 20945.895270523855, 21390.572188556143, 8877.01602836179, 9213.30900182489, 9639.084286992584, 10572.471376431147, 10797.946010269898, 8095.433319667567, 8919.241864441596, 8925.509096999467, 8945.642174312954, 9073.092690730875, 18215.45353639393, 18332.17505212242, 18573.349932752288, 18738.531536711693, 19005.904970475058, 18441.538961525534, 18558.0, 18680.813191867906, 18697.252109915997, 18733.250669973593, 10843.132549396187, 11049.33703977764, 11060.22578419535, 11065.336079835235, 11091.72270693239, 13689.520866769615, 13694.794578081137, 13729.725405491634, 13908.304584770924, 13926.721465570834, 10196.745081373025, 10206.693799186036, 10506.21203409732, 10545.10366618846, 10681.732956676145, 10405.895941040493, 10480.109190718875, 10597.788044239227, 10705.571777129138, 11037.503312351124, 9900.108990190918, 10103.393796372242, 10113.797724045331, 10119.038691324313, 10121.493925303852, 7624.5425274483705, 7629.580373079534, 7649.617519124133, 7717.961410192913, 7850.646720897687, 7681.884771728541, 7708.730194443167, 7708.884366734392, 7750.186230445722, 7802.024746906637], "value": 6543.206403122442, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [509.98470045898625, 521.70002248707, 540.7242306423727, 541.2638811216744, 543.9918401223981, 6345.873082538352, 6375.234971803378, 6376.904346434807, 6406.0, 6408.903866442007, 6105.877882442349, 6211.347808480113, 6255.562110652256, 6353.570446649502, 6353.602207514351, 5093.516115968995, 5126.7436628168625, 5135.64050516464, 5140.922886156711, 5154.355705536808, 5087.66930149541, 5117.385913690344, 5133.6919784813035, 5138.563222126105, 5140.588752899759, 4950.480199579047, 5135.486451354872, 5138.794448222066, 5152.484751524855, 5153.149730294497, 5101.336826212606, 5115.437301896788, 5143.717095559743, 5174.818881339153, 5184.222366644995, 4570.954290457086, 4578.954210457886, 4602.148602508513, 4602.263637817933, 4602.976985115053, 6117.990531562287, 6165.537584681122, 6247.281562620311, 6272.498200143978, 6283.465905398047, 5859.4140585941495, 5873.2658417697785, 5899.115132730082, 5914.260717410324, 5914.349421563625, 6648.570557330149, 6689.565178263398, 6733.595984240961, 6741.258461569223, 6757.290484499106, 4940.777665005084, 4978.551930326288, 4987.900241995176, 5000.699958002531, 5000.89998200034, 6986.930130698679, 6997.790066298019, 7003.754868579626, 7045.330693584101, 7072.964635176842, 5106.591472682177, 5194.584433245332, 5195.324607801037, 5199.766010529535, 5213.530782229617, 5100.974495127575, 5125.769340379692, 5149.201873709506, 5158.226266060121, 5163.715995620202, 5737.627054241461, 5766.682832444172, 5772.249607551075, 5815.73829177688, 5854.443827836349, 6624.27133015368, 6789.490788190807, 6815.318468153244, 6816.284290149562, 6834.214065382445, 1687.4262750664832, 1799.2802878848304, 1799.7480352750626, 1802.765640466731, 1819.6269764698204, 1177.3406892140429, 1208.293148508115, 1237.2329155923385, 1256.9371531423392, 1283.6983308922395, 5672.631278966854, 5702.201691763156, 5745.482906538432, 5759.366469688331, 5766.365699773021, 6613.0, 6667.133272674619, 6725.899111513331, 6734.696938637773, 6777.559458635173, 5623.437656234426, 5718.456746609066, 5720.256366672306, 5747.770089196385, 5798.420157984167, 3559.323728491578, 3603.85584576614, 3616.475611036385, 3617.963820361815, 3657.3599620066384, 6489.318621544764, 6528.640924749185, 6550.246721626979, 6569.277379488252, 6634.303398143222, 6957.686904089328, 6988.650567471708, 7032.296770323029, 7052.33002864727, 7058.188308344504, 6539.149910511603, 6586.670666466657, 6612.669366531654, 6626.469882409299, 6681.832954176184, 6758.898616520658, 6780.762673306608, 6826.761063362758, 6847.828804279933, 6867.214524223637, 6649.4680425564875, 6673.499487538551, 6731.293214212437, 6732.259451460433, 6746.291639377991, 6368.745250190126, 6569.770058047945, 6573.605583664996, 6589.17635295588, 6616.0, 5082.440931497458, 5096.261042148942, 5126.6923984561045, 5132.717700526507, 5144.897102058013, 6555.180602424697, 6723.294054124247, 6724.865502689821, 6770.15933607473, 6789.15135608049, 6431.163948686828, 6434.903476447764, 6528.608283503005, 6593.241777195492, 6631.502637302318, 6394.4564712, 6433.903491447539, 6454.0, 6552.63960482178, 6571.211454625475, 6292.280789407944, 6401.687654030819, 6434.935650643621, 6444.13004244421, 6499.902501462388, 6224.657643829632, 6431.453326467303, 6608.273089960197, 6660.733570657313, 6670.466362691071, 5881.38245484218, 6200.224971878515, 6218.502519798315, 6384.329645387167, 6469.708863101077], "value": 5128.715099584165, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [884.0805562215296, 898.6674930275798, 918.5866360137935, 926.4765407544737, 929.8093890752397, 19284.614307713855, 20194.889281089534, 20647.483812904647, 20661.793382066175, 20664.380068597966, 18069.1868865901, 18690.813091869077, 18860.302572768447, 19002.0, 19069.237230510764, 955.254901177083, 962.4706411473696, 969.5830792759111, 971.6744890461669, 972.3388096094653, 963.1812958984842, 994.1450352696675, 994.5474808961905, 997.7705127820606, 998.8152191844496, 1045.5242864496674, 1049.4333060147512, 1054.5676272728183, 1054.8628678271814, 1055.5461151704765, 1057.6245432871335, 1058.4760543530924, 1060.782539579392, 1060.7984482948293, 1061.2624226162782, 727.6252729844134, 749.5914726474085, 759.5556599389308, 772.5596410046276, 778.9454738168331, 20589.79410205894, 20683.276085337093, 20734.170633174654, 20813.479663008395, 20814.16743330265, 21814.781852181433, 22022.11911523537, 22399.88800055989, 22498.325050248517, 22584.20955266558, 17531.0, 17730.29078836845, 17808.198631061634, 17924.91037544817, 18036.819631803777, 3740.7942563159286, 3760.6427389397963, 3762.9247415051545, 3765.8870233893026, 3768.4724138620613, 148699.0, 149037.99999999892, 149254.0, 149975.25012374867, 152206.23896880445, 17400.0, 17406.129693515275, 17429.0, 17659.470215893543, 17697.38059167923, 30917.38165236683, 30944.535831962537, 31150.22124446907, 31187.532187017212, 31216.21959451032, 7654.464187506933, 8359.164083591713, 8454.239118479367, 8557.187067228604, 8586.098459661645, 4030.496187976503, 4107.178564287155, 4114.1977314424, 4117.197146556393, 4127.7936103194725, 5544.805931792368, 5636.971815140898, 5637.436256374412, 5652.463016013472, 5652.971735141298, 1045.0490054050777, 1047.4500887034217, 1054.4991129213715, 1057.370864335719, 1062.5696592879897, 664.7706541243264, 676.4960104722013, 677.4715721737053, 685.1640997982454, 692.0829900382014, 11495.885041149482, 11767.176297659253, 11805.822912656316, 12268.509259629693, 12400.069994750429, 689.1764341611726, 691.799378180322, 692.3215249055853, 706.2584286499156, 707.434052757802, 5278.313819203479, 5419.105847535191, 5420.756065977041, 5438.83683489496, 5456.290682211366, 123467.0, 123688.0, 124057.37971310086, 124380.37809811074, 127665.36167319104, 110781.0, 110969.44515277534, 113035.0, 114541.0, 117288.41355793166, 100810.4959475198, 101032.0, 101620.49189754004, 102105.48947255216, 102128.0, 10009.199264059003, 10135.391876487434, 10203.84694229602, 10306.948465257627, 10342.586296548356, 44366.0, 44550.55449445464, 45367.09265814731, 45545.0, 46752.532474674816, 57658.0, 57856.4214357851, 58286.4171358281, 60641.393586063576, 61223.0, 14514.419423222953, 14904.329305181509, 14943.178125203218, 14949.476768313492, 15028.849711502746, 17085.402010929556, 17565.912170439577, 17718.557036074202, 17818.10909454496, 17833.554161146076, 16969.406070787463, 16980.575485612466, 17072.0, 17184.914075430042, 17287.394941176997, 16145.596360090622, 16540.66918661644, 16592.087435190697, 16747.497575072768, 16754.91622541928, 14853.108813471226, 14925.626859328604, 15038.323275452412, 15202.771958420411, 15218.543443696706, 11706.88293117058, 11739.0, 11761.235519691534, 11768.58809941648, 12109.455074521844, 12468.812967805308, 12661.493540258287, 12667.30329831868, 12713.745725085631, 12727.23636581808], "value": 9060.989424302088, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1408.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 108.0, 107.0, 107.0, 109.0, 107.0, 107.0, 106.0, 106.0, 108.0], "value": 107.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 119.0, 115.0, 117.0, 118.0, 115.0, 116.0, 123.0, 120.0], "value": 117.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 165.0, 162.0, 164.0, 163.0, 164.0, 164.0, 171.0, 170.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 75.0, 74.0, 73.0, 77.0, 75.0, 75.0, 75.0], "value": 75.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 78.0, 78.0, 79.0, 79.0, 80.0, 84.0, 80.0], "value": 79.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 111.0, 111.0, 112.0, 112.0, 112.0, 113.0, 112.0, 112.0, 112.0], "value": 113.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 148.0, 149.0, 147.0, 148.0, 149.0, 147.0, 148.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 98.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 55.0, 55.0, 51.0, 51.0, 52.0, 52.0, 53.0, 51.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 38.0, 37.0, 37.0, 37.0, 37.0, 37.0, 37.0, 37.0, 37.0], "value": 37.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 74.0, 74.0, 75.0, 76.0, 74.0, 77.0, 76.0, 73.0, 73.0], "value": 75.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 115.0, 108.0, 112.0, 111.0, 115.0, 111.0, 112.0, 116.0, 113.0], "value": 112.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 172.0, 171.0, 161.0, 167.0, 159.0, 162.0, 167.0, 158.0, 158.0], "value": 163.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 63.0, 68.0, 64.0, 66.0, 67.0, 63.0, 71.0, 73.0], "value": 66.4, "unit": "score"}]}]} 16:00:06 INFO - Return code: 0 16:00:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:00:06 INFO - # TBPL SUCCESS # 16:00:06 INFO - Running post-action listener: _package_coverage_data 16:00:06 INFO - Running post-action listener: _resource_record_post_action 16:00:06 INFO - [mozharness: 2017-09-29 23:00:06.599631Z] Finished run-tests step (success) 16:00:06 INFO - Running post-run listener: _resource_record_post_run 16:00:06 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 8192; Write bytes: 337203200; Read time: 24; Write time: 247492 16:00:06 INFO - TinderboxPrint: CPU usage
13.1% 16:00:06 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 24 16:00:06 INFO - TinderboxPrint: I/O write bytes / time
337,203,200 / 247,492 16:00:06 INFO - TinderboxPrint: CPU idle
8,234.5 (86.9%) 16:00:06 INFO - TinderboxPrint: CPU user
1,195.6 (12.6%) 16:00:06 INFO - TinderboxPrint: Swap in / out
0 / 0 16:00:06 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13774848; Read time: 0; Write time: 1144 16:00:06 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:06 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 322916352; Read time: 12; Write time: 246344 16:00:07 INFO - Running post-run listener: _upload_blobber_files 16:00:07 INFO - Blob upload gear active. 16:00:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:00:07 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:07 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:07 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:07 INFO - (blobuploader) - INFO - Open directory for files ... 16:00:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:00:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:00:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:00:08 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:00:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:00:08 INFO - (blobuploader) - INFO - Done attempting. 16:00:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:00:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:00:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:00:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:00:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:00:15 INFO - (blobuploader) - INFO - Done attempting. 16:00:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:00:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:00:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:00:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:00:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:00:16 INFO - (blobuploader) - INFO - Done attempting. 16:00:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:00:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:00:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:00:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:00:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:00:18 INFO - (blobuploader) - INFO - Done attempting. 16:00:18 INFO - (blobuploader) - INFO - Iteration through files over. 16:00:18 INFO - Return code: 0 16:00:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:00:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:00:18 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/966b2675fe485872bc83df377b13294e516df48720d316309b7eaf090b4591904084ea7835ca2fd33524bc2c4fcaad442e3f679cb898a905468411377d125ac1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6d905f457524a0851ea977b653884b60511cdf294b282cba7dd799eb3616a4e22219cef392b65761a1611e047b94eaeeb1c2d7d5eb701e7dfdc8df125569a906", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b1b88fdd106b305621ec83648583b5235792d3655befdae5062cf55da8ab791a6834662a3330f0b9c2268adab37bb0823cf719c55c4152091913c48348936f99", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0506aaf9d035993e44fa155356c0d096a5d89e3b342de1198393a36f61abd5b725f909ed4f60b69d78747612717dc099d7b3cb91a5bce524a4bbf723043911d6"} 16:00:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:00:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:00:18 INFO - Contents: 16:00:18 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/966b2675fe485872bc83df377b13294e516df48720d316309b7eaf090b4591904084ea7835ca2fd33524bc2c4fcaad442e3f679cb898a905468411377d125ac1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6d905f457524a0851ea977b653884b60511cdf294b282cba7dd799eb3616a4e22219cef392b65761a1611e047b94eaeeb1c2d7d5eb701e7dfdc8df125569a906", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b1b88fdd106b305621ec83648583b5235792d3655befdae5062cf55da8ab791a6834662a3330f0b9c2268adab37bb0823cf719c55c4152091913c48348936f99", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0506aaf9d035993e44fa155356c0d096a5d89e3b342de1198393a36f61abd5b725f909ed4f60b69d78747612717dc099d7b3cb91a5bce524a4bbf723043911d6"} 16:00:18 INFO - Running post-run listener: copy_logs_to_upload_dir 16:00:18 INFO - Copying logs to upload dir... 16:00:18 INFO - mkdir: /builds/slave/test/build/upload/logs 16:00:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.765885 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-29 16:00:18.520064) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-29 16:00:18.526978) ========= 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=9bfb7e13875ed353a705960e000001c0-1506723941.230278-256094443 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/966b2675fe485872bc83df377b13294e516df48720d316309b7eaf090b4591904084ea7835ca2fd33524bc2c4fcaad442e3f679cb898a905468411377d125ac1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6d905f457524a0851ea977b653884b60511cdf294b282cba7dd799eb3616a4e22219cef392b65761a1611e047b94eaeeb1c2d7d5eb701e7dfdc8df125569a906", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b1b88fdd106b305621ec83648583b5235792d3655befdae5062cf55da8ab791a6834662a3330f0b9c2268adab37bb0823cf719c55c4152091913c48348936f99", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0506aaf9d035993e44fa155356c0d096a5d89e3b342de1198393a36f61abd5b725f909ed4f60b69d78747612717dc099d7b3cb91a5bce524a4bbf723043911d6"} build_url:https://queue.taskcluster.net/v1/task/G34YYNMNSWCHGxZu1JukKw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011206 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/966b2675fe485872bc83df377b13294e516df48720d316309b7eaf090b4591904084ea7835ca2fd33524bc2c4fcaad442e3f679cb898a905468411377d125ac1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6d905f457524a0851ea977b653884b60511cdf294b282cba7dd799eb3616a4e22219cef392b65761a1611e047b94eaeeb1c2d7d5eb701e7dfdc8df125569a906", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b1b88fdd106b305621ec83648583b5235792d3655befdae5062cf55da8ab791a6834662a3330f0b9c2268adab37bb0823cf719c55c4152091913c48348936f99", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0506aaf9d035993e44fa155356c0d096a5d89e3b342de1198393a36f61abd5b725f909ed4f60b69d78747612717dc099d7b3cb91a5bce524a4bbf723043911d6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-29 16:00:18.555238) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 16:00:18.557595) ========= 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=9bfb7e13875ed353a705960e000001c0-1506723941.230278-256094443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004456 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 16:00:18.639372) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-29 16:00:18.641718) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-29 16:00:18.642018) ========= ========= Total master_lag: 0.30 =========