builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-086 starttime: 1505585545.92 results: success (0) revision: 34e2566a71f160eb3c5c3d92626453852e818f18 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 11:12:25.923860) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 11:12:25.924214) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 11:12:25.924759) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 11:12:25.942532) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 11:12:25.942842) ========= 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=438111f3d31ce799eff2119d000001bc-1505584246.40180-676488900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-16 11:12: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% 33.1M=0s 2017-09-16 11:12:25 (33.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.073805 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 11:12:26.033040) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 11:12:26.033330) ========= 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=438111f3d31ce799eff2119d000001bc-1505584246.40180-676488900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021415 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 11:12:26.087346) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-09-16 11:12:26.087650) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 34e2566a71f160eb3c5c3d92626453852e818f18 --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 34e2566a71f160eb3c5c3d92626453852e818f18 --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=438111f3d31ce799eff2119d000001bc-1505584246.40180-676488900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-16 11:12:26,103 truncating revision to first 12 chars 2017-09-16 11:12:26,103 Setting DEBUG logging. 2017-09-16 11:12:26,103 attempt 1/10 2017-09-16 11:12:26,103 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/34e2566a71f1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-16 11:12:26,576 attempt 1/10 2017-09-16 11:12:27,331 current task status: no status available at this point. state: STARTED 2017-09-16 11:12:27,331 sleeping for 9.00s (attempt 1/10) 2017-09-16 11:12:36,341 attempt 2/10 2017-09-16 11:12:36,673 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-09-16 11:12:36,858 unpacking tar archive at: mozilla-central-34e2566a71f1/testing/mozharness/ program finished with exit code 0 elapsedTime=11.058091 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-09-16 11:12:37.167347) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 11:12:37.167665) ========= script_repo_revision: 34e2566a71f160eb3c5c3d92626453852e818f18 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 11:12:37.168044) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 11:12:37.168310) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 11:12:37.181674) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-16 11:12:37.182041) ========= /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=438111f3d31ce799eff2119d000001bc-1505584246.40180-676488900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:12:37 INFO - MultiFileLogger online at 20170916 11:12:37 in /builds/slave/test 11:12:37 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 11:12:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:12:37 INFO - {'append_to_log': False, 11:12:37 INFO - 'base_work_dir': '/builds/slave/test', 11:12:37 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 11:12:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:12:37 INFO - 'branch': 'Firefox-Non-PGO', 11:12:37 INFO - 'buildbot_json_path': 'buildprops.json', 11:12:37 INFO - 'code_coverage': False, 11:12:37 INFO - 'config_files': ('talos/linux_config.py',), 11:12:37 INFO - 'default_actions': ('clobber', 11:12:37 INFO - 'read-buildbot-config', 11:12:37 INFO - 'download-and-extract', 11:12:37 INFO - 'populate-webroot', 11:12:37 INFO - 'create-virtualenv', 11:12:37 INFO - 'install', 11:12:37 INFO - 'setup-mitmproxy', 11:12:37 INFO - 'run-tests'), 11:12:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:12:37 INFO - 'disable_ccov_upload': False, 11:12:37 INFO - 'disable_stylo': False, 11:12:37 INFO - 'download_minidump_stackwalk': True, 11:12:37 INFO - 'download_symbols': 'ondemand', 11:12:37 INFO - 'enable_stylo': False, 11:12:37 INFO - 'enable_webrender': False, 11:12:37 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:12:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:12:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:12:37 INFO - 'gecko_profile': False, 11:12:37 INFO - 'gecko_profile_interval': 0, 11:12:37 INFO - 'installer_path': 'installer.exe', 11:12:37 INFO - 'log_level': 'info', 11:12:37 INFO - 'log_name': 'talos', 11:12:37 INFO - 'log_to_console': True, 11:12:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:12:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:12:37 INFO - 'opt_config_files': (), 11:12:37 INFO - 'pip_index': False, 11:12:37 INFO - 'suite': 'dromaeojs-e10s', 11:12:37 INFO - 'system_bits': '32', 11:12:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:12:37 INFO - 'title': 'talos-linux64-ix-086', 11:12:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:12:37 INFO - 'use_talos_json': True, 11:12:37 INFO - 'verify': 'False', 11:12:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:12:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:12:37 INFO - 'work_dir': 'build'} 11:12:37 INFO - [mozharness: 2017-09-16 18:12:37.333573Z] Running clobber step. 11:12:37 INFO - Running pre-action listener: _resource_record_pre_action 11:12:37 INFO - Running main action method: clobber 11:12:37 INFO - rmtree: /builds/slave/test/build 11:12:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:12:38 INFO - Running post-action listener: _resource_record_post_action 11:12:38 INFO - [mozharness: 2017-09-16 18:12:38.350772Z] Finished clobber step (success) 11:12:38 INFO - [mozharness: 2017-09-16 18:12:38.350870Z] Running read-buildbot-config step. 11:12:38 INFO - Running pre-action listener: _resource_record_pre_action 11:12:38 INFO - Running main action method: read_buildbot_config 11:12:38 INFO - Using buildbot properties: 11:12:38 INFO - { 11:12:38 INFO - "project": "", 11:12:38 INFO - "product": "firefox", 11:12:38 INFO - "who": "ffxbld@noreply.mozilla.org", 11:12:38 INFO - "installer_path": "public/build/target.tar.bz2", 11:12:38 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 11:12:38 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:12:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 11:12:38 INFO - "stage_platform": "linux64", 11:12:38 INFO - "basedir": "/builds/slave/test", 11:12:38 INFO - "buildnumber": 833, 11:12:38 INFO - "platform": "ubuntu64_hw", 11:12:38 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:12:38 INFO - "slavebuilddir": "test", 11:12:38 INFO - "taskId": "ay8Ab6-iR2ysgKGJ3l-E-Q", 11:12:38 INFO - "branch": "mozilla-central", 11:12:38 INFO - "script_repo_revision": "production", 11:12:38 INFO - "revision": "34e2566a71f160eb3c5c3d92626453852e818f18", 11:12:38 INFO - "slavename": "talos-linux64-ix-086", 11:12:38 INFO - "repo_path": "mozilla-central" 11:12:38 INFO - } 11:12:38 INFO - Finding installer, test and symbols from parent task. 11:12:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ay8Ab6-iR2ysgKGJ3l-E-Q'}, attempt #1 11:12:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ay8Ab6-iR2ysgKGJ3l-E-Q'}, attempt #1 11:12:39 INFO - Task dependencies: MWFstPgVRxqTsnauXlFVFQ 11:12:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MWFstPgVRxqTsnauXlFVFQ'}, attempt #1 11:12:39 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/MWFstPgVRxqTsnauXlFVFQ/artifacts/public/build/target.tar.bz2 11:12:39 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/MWFstPgVRxqTsnauXlFVFQ/artifacts/public/build/target.test_packages.json 11:12:39 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/MWFstPgVRxqTsnauXlFVFQ/artifacts/public/build/target.crashreporter-symbols.zip 11:12:39 INFO - Running post-action listener: _resource_record_post_action 11:12:39 INFO - [mozharness: 2017-09-16 18:12:39.795088Z] Finished read-buildbot-config step (success) 11:12:39 INFO - [mozharness: 2017-09-16 18:12:39.795307Z] Running download-and-extract step. 11:12:39 INFO - Running pre-action listener: _resource_record_pre_action 11:12:39 INFO - Running main action method: download_and_extract 11:12:39 INFO - mkdir: /builds/slave/test/build/tests 11:12:39 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')]} 11:12:39 INFO - trying https://queue.taskcluster.net/v1/task/MWFstPgVRxqTsnauXlFVFQ/artifacts/public/build/target.test_packages.json 11:12:39 INFO - Downloading https://queue.taskcluster.net/v1/task/MWFstPgVRxqTsnauXlFVFQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:12:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MWFstPgVRxqTsnauXlFVFQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:12:40 INFO - Downloaded 989 bytes. 11:12:40 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:12:40 INFO - Using the following test package requirements: 11:12:40 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:12:40 INFO - u'common': [u'target.common.tests.zip'], 11:12:40 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:12:40 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:12:40 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:12:40 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:12:40 INFO - u'mozbase': [u'target.common.tests.zip'], 11:12:40 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:12:40 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:12:40 INFO - u'web-platform': [u'target.common.tests.zip', 11:12:40 INFO - u'target.web-platform.tests.tar.gz'], 11:12:40 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:12:40 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:12:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MWFstPgVRxqTsnauXlFVFQ/artifacts/public/build/target.common.tests.zip 11:12:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MWFstPgVRxqTsnauXlFVFQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:12:40 INFO - Fetch https://queue.taskcluster.net/v1/task/MWFstPgVRxqTsnauXlFVFQ/artifacts/public/build/target.common.tests.zip into memory 11:12:41 INFO - Content-Length response header: 54731154 11:12:41 INFO - Bytes received: 54731154 11:12:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MWFstPgVRxqTsnauXlFVFQ/artifacts/public/build/target.talos.tests.zip 11:12:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MWFstPgVRxqTsnauXlFVFQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:12:52 INFO - Fetch https://queue.taskcluster.net/v1/task/MWFstPgVRxqTsnauXlFVFQ/artifacts/public/build/target.talos.tests.zip into memory 11:12:53 INFO - Content-Length response header: 14508748 11:12:53 INFO - Bytes received: 14508748 11:12:53 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')]} 11:12:53 INFO - trying https://queue.taskcluster.net/v1/task/MWFstPgVRxqTsnauXlFVFQ/artifacts/public/build/target.tar.bz2 11:12:53 INFO - Downloading https://queue.taskcluster.net/v1/task/MWFstPgVRxqTsnauXlFVFQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:12:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MWFstPgVRxqTsnauXlFVFQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:12:54 INFO - Downloaded 61516366 bytes. 11:12:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MWFstPgVRxqTsnauXlFVFQ/artifacts/public/build/target.tar.bz2 11:12:54 INFO - mkdir: /builds/slave/test/properties 11:12:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:12:54 INFO - Writing to file /builds/slave/test/properties/build_url 11:12:54 INFO - Contents: 11:12:54 INFO - build_url:https://queue.taskcluster.net/v1/task/MWFstPgVRxqTsnauXlFVFQ/artifacts/public/build/target.tar.bz2 11:12:54 INFO - Running post-action listener: _resource_record_post_action 11:12:54 INFO - Running post-action listener: find_tests_for_verification 11:12:54 INFO - Running post-action listener: set_extra_try_arguments 11:12:54 INFO - [mozharness: 2017-09-16 18:12:54.389926Z] Finished download-and-extract step (success) 11:12:54 INFO - [mozharness: 2017-09-16 18:12:54.390023Z] Running populate-webroot step. 11:12:54 INFO - Running pre-action listener: _resource_record_pre_action 11:12:54 INFO - Running main action method: populate_webroot 11:12:54 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:12:54 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:12:54 INFO - 'tests': ['tresize', 11:12:54 INFO - 'tcanvasmark']}, 11:12:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:12:54 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:12:54 INFO - 'tests': ['dromaeo_css', 11:12:54 INFO - 'kraken']}, 11:12:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:12:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:12:54 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:12:54 INFO - 'talos_options': ['--disable-stylo'], 11:12:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:12:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:12:54 INFO - 'tests': ['damp', 'tps']}, 11:12:54 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:12:54 INFO - 'talos_options': ['--disable-stylo'], 11:12:54 INFO - 'tests': ['damp', 'tps']}, 11:12:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:12:54 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:12:54 INFO - 'tests': ['dromaeo_dom']}, 11:12:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:12:54 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:12:54 INFO - 'tests': ['basic_compositor_video', 11:12:54 INFO - 'glvideo']}, 11:12:54 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:12:54 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:12:54 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:12:54 INFO - 'talos_options': ['--disable-stylo'], 11:12:54 INFO - 'tests': ['ts_paint_webext', 11:12:54 INFO - 'tp5o_webext']}, 11:12:54 INFO - 'other-e10s': {'tests': ['a11yr', 11:12:54 INFO - 'ts_paint', 11:12:54 INFO - 'tpaint', 11:12:54 INFO - 'sessionrestore', 11:12:54 INFO - 'sessionrestore_many_windows', 11:12:54 INFO - 'sessionrestore_no_auto_restore', 11:12:54 INFO - 'tabpaint']}, 11:12:54 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:12:54 INFO - 'tests': ['a11yr', 11:12:54 INFO - 'ts_paint', 11:12:54 INFO - 'tpaint', 11:12:54 INFO - 'sessionrestore', 11:12:54 INFO - 'sessionrestore_many_windows', 11:12:54 INFO - 'sessionrestore_no_auto_restore', 11:12:54 INFO - 'tabpaint']}, 11:12:54 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:12:54 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 11:12:54 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:12:54 INFO - 'tests': ['perf_reftest_singletons']}, 11:12:54 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:12:54 INFO - 'tests': ['bloom_basic']}, 11:12:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:12:54 INFO - 'tsvgr_opacity', 11:12:54 INFO - 'tart', 11:12:54 INFO - 'tscrollx', 11:12:54 INFO - 'tsvg_static']}, 11:12:54 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:12:54 INFO - 'tests': ['tsvgx', 11:12:54 INFO - 'tsvgr_opacity', 11:12:54 INFO - 'tart', 11:12:54 INFO - 'tscrollx', 11:12:54 INFO - 'tsvg_static']}, 11:12:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:12:54 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:12:54 INFO - 'talos_options': ['--disable-stylo'], 11:12:54 INFO - 'tests': ['tp5o']}, 11:12:54 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:12:54 INFO - 'talos_options': ['--mitmproxy', 11:12:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:12:54 INFO - '--firstNonBlankPaint'], 11:12:54 INFO - 'tests': ['tp6_google', 11:12:54 INFO - 'tp6_youtube', 11:12:54 INFO - 'tp6_amazon', 11:12:54 INFO - 'tp6_facebook']}, 11:12:54 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:12:54 INFO - 'talos_options': ['--disable-stylo', 11:12:54 INFO - '--mitmproxy', 11:12:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:12:54 INFO - '--firstNonBlankPaint'], 11:12:54 INFO - 'tests': ['tp6_google', 11:12:54 INFO - 'tp6_youtube', 11:12:54 INFO - 'tp6_amazon', 11:12:54 INFO - 'tp6_facebook']}, 11:12:54 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:12:54 INFO - 'talos_options': ['--stylo-threads=1', 11:12:54 INFO - '--mitmproxy', 11:12:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:12:54 INFO - '--firstNonBlankPaint'], 11:12:54 INFO - 'tests': ['tp6_google', 11:12:54 INFO - 'tp6_youtube', 11:12:54 INFO - 'tp6_amazon', 11:12:54 INFO - 'tp6_facebook']}, 11:12:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:12:54 INFO - 'talos_options': ['--xperf_path', 11:12:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:12:54 INFO - 'tests': ['tp5n']}, 11:12:54 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:12:54 INFO - 'talos_options': ['--disable-stylo', 11:12:54 INFO - '--xperf_path', 11:12:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:12:54 INFO - 'tests': ['tp5n']}}} 11:12:54 INFO - Running post-action listener: _resource_record_post_action 11:12:54 INFO - [mozharness: 2017-09-16 18:12:54.405196Z] Finished populate-webroot step (success) 11:12:54 INFO - [mozharness: 2017-09-16 18:12:54.405285Z] Running create-virtualenv step. 11:12:54 INFO - Running pre-action listener: _resource_record_pre_action 11:12:54 INFO - Running main action method: create_virtualenv 11:12:54 INFO - Creating virtualenv /builds/slave/test/build/venv 11:12:54 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:12:54 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:12:54 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:12:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:12:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:12:55 INFO - Installing distribute.............................................................................................................................................................................................done. 11:12:55 INFO - Installing pip...............done. 11:12:55 INFO - Return code: 0 11:12:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:12:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:12:55 INFO - Reading from file tmpfile_stdout 11:12:55 INFO - Output received: 11:12:55 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:12:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:12: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')]} 11:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12: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')]} 11:12:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x214b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2314a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bb090>, '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 0x24bbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b5f90>, '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': '438111f3d31ce799eff2119d000001bc-1505584246.40180-676488900', '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 11:12:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:12:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:12:55 INFO - Using env: {'DISPLAY': ':0', 11:12:55 INFO - 'HOME': '/home/cltbld', 11:12:55 INFO - 'LANG': 'en_US.UTF-8', 11:12:55 INFO - 'LANGUAGE': 'en_US:en', 11:12:55 INFO - 'LOGNAME': 'cltbld', 11:12:55 INFO - 'MAIL': '/var/mail/cltbld', 11:12:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:55 INFO - 'MOZ_NO_REMOTE': '1', 11:12:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:55 INFO - 'NO_EM_RESTART': '1', 11:12:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:55 INFO - 'PWD': '/builds/slave/test', 11:12:55 INFO - 'SHELL': '/bin/bash', 11:12:55 INFO - 'SHLVL': '1', 11:12:55 INFO - 'TERM': 'linux', 11:12:55 INFO - 'TMOUT': '86400', 11:12:55 INFO - 'USER': 'cltbld', 11:12:55 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1505584246.40180-676488900', 11:12:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:55 INFO - '_': '/tools/buildbot/bin/python'} 11:12:56 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:12:56 INFO - Downloading/unpacking pip>=1.5 11:12:56 INFO - Running setup.py egg_info for package pip 11:12:56 INFO - warning: no files found matching 'pip/cacert.pem' 11:12:56 INFO - warning: no files found matching '*.html' under directory 'docs' 11:12:56 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:12:56 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:12:56 INFO - Installing collected packages: pip 11:12:56 INFO - Found existing installation: pip 1.1 11:12:56 INFO - Uninstalling pip: 11:12:56 INFO - Successfully uninstalled pip 11:12:56 INFO - Running setup.py install for pip 11:12:56 INFO - warning: no files found matching 'pip/cacert.pem' 11:12:56 INFO - warning: no files found matching '*.html' under directory 'docs' 11:12:56 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:12:56 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:12:56 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:12:56 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:12:56 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:12:56 INFO - Successfully installed pip 11:12:56 INFO - Cleaning up... 11:12:56 INFO - Return code: 0 11:12:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:12:56 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')]} 11:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:56 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')]} 11:12:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:56 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 0x214b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2314a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bb090>, '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 0x24bbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b5f90>, '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': '438111f3d31ce799eff2119d000001bc-1505584246.40180-676488900', '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 11:12:56 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 11:12:56 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 11:12:56 INFO - Using env: {'DISPLAY': ':0', 11:12:56 INFO - 'HOME': '/home/cltbld', 11:12:56 INFO - 'LANG': 'en_US.UTF-8', 11:12:56 INFO - 'LANGUAGE': 'en_US:en', 11:12:56 INFO - 'LOGNAME': 'cltbld', 11:12:56 INFO - 'MAIL': '/var/mail/cltbld', 11:12:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:56 INFO - 'MOZ_NO_REMOTE': '1', 11:12:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:56 INFO - 'NO_EM_RESTART': '1', 11:12:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:56 INFO - 'PWD': '/builds/slave/test', 11:12:56 INFO - 'SHELL': '/bin/bash', 11:12:56 INFO - 'SHLVL': '1', 11:12:56 INFO - 'TERM': 'linux', 11:12:56 INFO - 'TMOUT': '86400', 11:12:56 INFO - 'USER': 'cltbld', 11:12:56 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1505584246.40180-676488900', 11:12:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:56 INFO - '_': '/tools/buildbot/bin/python'} 11:12:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:56 INFO - Downloading/unpacking psutil>=3.1.1 11:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:12:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:12:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:12:58 INFO - Installing collected packages: psutil 11:12:58 INFO - Running setup.py install for psutil 11:12:58 INFO - building 'psutil._psutil_linux' extension 11:12:58 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 11:12:58 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 11:12:58 INFO - building 'psutil._psutil_posix' extension 11:12:58 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 11:12:58 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 11:12:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:12:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:12:58 INFO - Successfully installed psutil 11:12:58 INFO - Cleaning up... 11:12:58 INFO - Return code: 0 11:12:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:12: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')]} 11:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12: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')]} 11:12:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x214b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2314a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bb090>, '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 0x24bbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b5f90>, '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': '438111f3d31ce799eff2119d000001bc-1505584246.40180-676488900', '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 11:12: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:12: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 mozsystemmonitor==0.3 11:12:58 INFO - Using env: {'DISPLAY': ':0', 11:12:58 INFO - 'HOME': '/home/cltbld', 11:12:58 INFO - 'LANG': 'en_US.UTF-8', 11:12:58 INFO - 'LANGUAGE': 'en_US:en', 11:12:58 INFO - 'LOGNAME': 'cltbld', 11:12:58 INFO - 'MAIL': '/var/mail/cltbld', 11:12:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:58 INFO - 'MOZ_NO_REMOTE': '1', 11:12:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:58 INFO - 'NO_EM_RESTART': '1', 11:12:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:58 INFO - 'PWD': '/builds/slave/test', 11:12:58 INFO - 'SHELL': '/bin/bash', 11:12:58 INFO - 'SHLVL': '1', 11:12:58 INFO - 'TERM': 'linux', 11:12:58 INFO - 'TMOUT': '86400', 11:12:58 INFO - 'USER': 'cltbld', 11:12:58 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1505584246.40180-676488900', 11:12:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:58 INFO - '_': '/tools/buildbot/bin/python'} 11:12:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:12: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 11:12: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 11:12: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 11:12: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 11:12:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:12:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:12:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:12:59 INFO - Installing collected packages: mozsystemmonitor 11:12:59 INFO - Running setup.py install for mozsystemmonitor 11:13:00 INFO - Successfully installed mozsystemmonitor 11:13:00 INFO - Cleaning up... 11:13:00 INFO - Return code: 0 11:13:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:13: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')]} 11:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13: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')]} 11:13:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x214b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2314a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bb090>, '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 0x24bbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b5f90>, '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': '438111f3d31ce799eff2119d000001bc-1505584246.40180-676488900', '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 11:13:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:13:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:13:00 INFO - Using env: {'DISPLAY': ':0', 11:13:00 INFO - 'HOME': '/home/cltbld', 11:13:00 INFO - 'LANG': 'en_US.UTF-8', 11:13:00 INFO - 'LANGUAGE': 'en_US:en', 11:13:00 INFO - 'LOGNAME': 'cltbld', 11:13:00 INFO - 'MAIL': '/var/mail/cltbld', 11:13:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:00 INFO - 'MOZ_NO_REMOTE': '1', 11:13:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:00 INFO - 'NO_EM_RESTART': '1', 11:13:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:00 INFO - 'PWD': '/builds/slave/test', 11:13:00 INFO - 'SHELL': '/bin/bash', 11:13:00 INFO - 'SHLVL': '1', 11:13:00 INFO - 'TERM': 'linux', 11:13:00 INFO - 'TMOUT': '86400', 11:13:00 INFO - 'USER': 'cltbld', 11:13:00 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1505584246.40180-676488900', 11:13:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:00 INFO - '_': '/tools/buildbot/bin/python'} 11:13:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:00 INFO - Downloading/unpacking jsonschema==2.5.1 11:13: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 11:13: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 11:13: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 11:13: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 11:13:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:13:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:13:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:02 INFO - Downloading functools32-3.2.3-2.tar.gz 11:13:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:13:02 INFO - warning: no files found matching '*.txt' 11:13:02 INFO - no previously-included directories found matching 'build' 11:13:02 INFO - no previously-included directories found matching 'dist' 11:13:02 INFO - no previously-included directories found matching '.git*' 11:13:02 INFO - Installing collected packages: jsonschema, functools32 11:13:02 INFO - Running setup.py install for functools32 11:13:02 INFO - warning: no files found matching '*.txt' 11:13:02 INFO - no previously-included directories found matching 'build' 11:13:02 INFO - no previously-included directories found matching 'dist' 11:13:02 INFO - no previously-included directories found matching '.git*' 11:13:02 INFO - Successfully installed jsonschema functools32 11:13:02 INFO - Cleaning up... 11:13:02 INFO - Return code: 0 11:13:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:13:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x214b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2314a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bb090>, '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 0x24bbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b5f90>, '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': '438111f3d31ce799eff2119d000001bc-1505584246.40180-676488900', '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 11:13:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:13:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:13:02 INFO - Using env: {'DISPLAY': ':0', 11:13:02 INFO - 'HOME': '/home/cltbld', 11:13:02 INFO - 'LANG': 'en_US.UTF-8', 11:13:02 INFO - 'LANGUAGE': 'en_US:en', 11:13:02 INFO - 'LOGNAME': 'cltbld', 11:13:02 INFO - 'MAIL': '/var/mail/cltbld', 11:13:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:02 INFO - 'MOZ_NO_REMOTE': '1', 11:13:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:02 INFO - 'NO_EM_RESTART': '1', 11:13:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:02 INFO - 'PWD': '/builds/slave/test', 11:13:02 INFO - 'SHELL': '/bin/bash', 11:13:02 INFO - 'SHLVL': '1', 11:13:02 INFO - 'TERM': 'linux', 11:13:02 INFO - 'TMOUT': '86400', 11:13:02 INFO - 'USER': 'cltbld', 11:13:02 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1505584246.40180-676488900', 11:13:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:02 INFO - '_': '/tools/buildbot/bin/python'} 11:13:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:13:02 INFO - Cleaning up... 11:13:02 INFO - Return code: 0 11:13:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:13:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x214b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2314a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bb090>, '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 0x24bbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b5f90>, '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': '438111f3d31ce799eff2119d000001bc-1505584246.40180-676488900', '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 11:13:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:13:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:13:02 INFO - Using env: {'DISPLAY': ':0', 11:13:02 INFO - 'HOME': '/home/cltbld', 11:13:02 INFO - 'LANG': 'en_US.UTF-8', 11:13:02 INFO - 'LANGUAGE': 'en_US:en', 11:13:02 INFO - 'LOGNAME': 'cltbld', 11:13:02 INFO - 'MAIL': '/var/mail/cltbld', 11:13:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:02 INFO - 'MOZ_NO_REMOTE': '1', 11:13:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:02 INFO - 'NO_EM_RESTART': '1', 11:13:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:02 INFO - 'PWD': '/builds/slave/test', 11:13:02 INFO - 'SHELL': '/bin/bash', 11:13:02 INFO - 'SHLVL': '1', 11:13:02 INFO - 'TERM': 'linux', 11:13:02 INFO - 'TMOUT': '86400', 11:13:02 INFO - 'USER': 'cltbld', 11:13:02 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1505584246.40180-676488900', 11:13:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:02 INFO - '_': '/tools/buildbot/bin/python'} 11:13:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:03 INFO - Downloading/unpacking blobuploader==1.2.4 11:13: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 11:13: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 11:13: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 11:13: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 11:13:04 INFO - Downloading blobuploader-1.2.4.tar.gz 11:13:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:13:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:13: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 11:13: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 11:13: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 11:13: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 11:13:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:13:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:13: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 11:13: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 11:13: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 11:13: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 11:13:04 INFO - Downloading docopt-0.6.1.tar.gz 11:13:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:13:04 INFO - Installing collected packages: blobuploader, requests, docopt 11:13:04 INFO - Running setup.py install for blobuploader 11:13:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:13:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:13:04 INFO - Running setup.py install for requests 11:13:05 INFO - Running setup.py install for docopt 11:13:05 INFO - Successfully installed blobuploader requests docopt 11:13:05 INFO - Cleaning up... 11:13:05 INFO - Return code: 0 11:13:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:13: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')]} 11:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13: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')]} 11:13:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x214b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2314a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bb090>, '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 0x24bbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b5f90>, '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': '438111f3d31ce799eff2119d000001bc-1505584246.40180-676488900', '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 11:13:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:13:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:13:05 INFO - Using env: {'DISPLAY': ':0', 11:13:05 INFO - 'HOME': '/home/cltbld', 11:13:05 INFO - 'LANG': 'en_US.UTF-8', 11:13:05 INFO - 'LANGUAGE': 'en_US:en', 11:13:05 INFO - 'LOGNAME': 'cltbld', 11:13:05 INFO - 'MAIL': '/var/mail/cltbld', 11:13:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:05 INFO - 'MOZ_NO_REMOTE': '1', 11:13:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:05 INFO - 'NO_EM_RESTART': '1', 11:13:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:05 INFO - 'PWD': '/builds/slave/test', 11:13:05 INFO - 'SHELL': '/bin/bash', 11:13:05 INFO - 'SHLVL': '1', 11:13:05 INFO - 'TERM': 'linux', 11:13:05 INFO - 'TMOUT': '86400', 11:13:05 INFO - 'USER': 'cltbld', 11:13:05 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1505584246.40180-676488900', 11:13:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:05 INFO - '_': '/tools/buildbot/bin/python'} 11:13:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:13:05 INFO - Running setup.py (path:/tmp/pip-gjXzre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:13:05 INFO - Running setup.py (path:/tmp/pip-ZsOkB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:13:05 INFO - Running setup.py (path:/tmp/pip-TGtqNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:13:05 INFO - Running setup.py (path:/tmp/pip-NGooQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:13:05 INFO - Running setup.py (path:/tmp/pip-145TLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:13:05 INFO - Running setup.py (path:/tmp/pip-Nofdn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:13:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:13:06 INFO - Running setup.py (path:/tmp/pip-THcvb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:13:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:13:06 INFO - Running setup.py (path:/tmp/pip-S7huWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:13:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:13:06 INFO - Running setup.py (path:/tmp/pip-7jomEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:13:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:13:06 INFO - Running setup.py (path:/tmp/pip-AjiZQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:13:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:13:06 INFO - Running setup.py (path:/tmp/pip-7fZyIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:13:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:13:06 INFO - Running setup.py (path:/tmp/pip-J4qQ8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:13:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:13:06 INFO - Running setup.py (path:/tmp/pip-iSww9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:13:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:13:06 INFO - Running setup.py (path:/tmp/pip-__OFob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:13:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:06 INFO - Running setup.py (path:/tmp/pip-zSne0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:13:06 INFO - Running setup.py (path:/tmp/pip-wDqr8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:13:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:13:06 INFO - Running setup.py (path:/tmp/pip-E6ScaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:13:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:13:06 INFO - Running setup.py install for manifestparser 11:13:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:13:06 INFO - Running setup.py install for mozcrash 11:13:06 INFO - Running setup.py install for mozdebug 11:13:07 INFO - Running setup.py install for mozdevice 11:13:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:13:07 INFO - Running setup.py install for mozfile 11:13:07 INFO - Running setup.py install for mozhttpd 11:13:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:13:07 INFO - Running setup.py install for mozinfo 11:13:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:13:07 INFO - Running setup.py install for mozInstall 11:13:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:13:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:13:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:13:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:13:07 INFO - Running setup.py install for mozleak 11:13:07 INFO - Running setup.py install for mozlog 11:13:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:13:07 INFO - Running setup.py install for moznetwork 11:13:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:13:07 INFO - Running setup.py install for mozprocess 11:13:08 INFO - Running setup.py install for mozprofile 11:13:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:13:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:13:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:13:08 INFO - Running setup.py install for mozrunner 11:13:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:13:08 INFO - Running setup.py install for mozscreenshot 11:13:08 INFO - Running setup.py install for moztest 11:13:08 INFO - Running setup.py install for mozversion 11:13:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:13:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:13:08 INFO - Cleaning up... 11:13:08 INFO - Return code: 0 11:13:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:13: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')]} 11:13:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13: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')]} 11:13:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:08 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 0x214b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2314a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bb090>, '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 0x24bbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b5f90>, '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': '438111f3d31ce799eff2119d000001bc-1505584246.40180-676488900', '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 11:13:08 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 11:13:08 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 11:13:08 INFO - Using env: {'DISPLAY': ':0', 11:13:08 INFO - 'HOME': '/home/cltbld', 11:13:08 INFO - 'LANG': 'en_US.UTF-8', 11:13:08 INFO - 'LANGUAGE': 'en_US:en', 11:13:08 INFO - 'LOGNAME': 'cltbld', 11:13:08 INFO - 'MAIL': '/var/mail/cltbld', 11:13:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:08 INFO - 'MOZ_NO_REMOTE': '1', 11:13:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:08 INFO - 'NO_EM_RESTART': '1', 11:13:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:08 INFO - 'PWD': '/builds/slave/test', 11:13:08 INFO - 'SHELL': '/bin/bash', 11:13:08 INFO - 'SHLVL': '1', 11:13:08 INFO - 'TERM': 'linux', 11:13:08 INFO - 'TMOUT': '86400', 11:13:08 INFO - 'USER': 'cltbld', 11:13:08 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1505584246.40180-676488900', 11:13:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:08 INFO - '_': '/tools/buildbot/bin/python'} 11:13:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:13:08 INFO - Running setup.py (path:/tmp/pip-6MBWoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:13:08 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)) 11:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:13:08 INFO - Running setup.py (path:/tmp/pip-izKnc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:13:08 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)) 11:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:13:08 INFO - Running setup.py (path:/tmp/pip-EhOxWO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:13:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:13:09 INFO - Running setup.py (path:/tmp/pip-ifvY_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:13:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:13:09 INFO - Running setup.py (path:/tmp/pip-gm6cLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:13:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:13:09 INFO - Running setup.py (path:/tmp/pip-PRNHNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:13:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:13:09 INFO - Running setup.py (path:/tmp/pip-TzHQK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:13:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:13:09 INFO - Running setup.py (path:/tmp/pip-OGFNmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:13:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:13:09 INFO - Running setup.py (path:/tmp/pip-vVbLVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:13:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:13:09 INFO - Running setup.py (path:/tmp/pip-xibMTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:13:09 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)) 11:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:13:09 INFO - Running setup.py (path:/tmp/pip-Bfv4TP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:13:09 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)) 11:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:13:09 INFO - Running setup.py (path:/tmp/pip-uUItbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:13:09 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)) 11:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:13:09 INFO - Running setup.py (path:/tmp/pip-0KCB69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:13:09 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)) 11:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:13:09 INFO - Running setup.py (path:/tmp/pip-K1Zq1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:13:09 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)) 11:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:09 INFO - Running setup.py (path:/tmp/pip-NXCkDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:09 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)) 11:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:13:09 INFO - Running setup.py (path:/tmp/pip-k8yzXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:13:09 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)) 11:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:13:09 INFO - Running setup.py (path:/tmp/pip-M3y0o6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:13:09 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)) 11:13:09 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)) 11:13:09 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)) 11:13:09 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)) 11:13:09 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)) 11:13:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:13:10 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:13:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:11 INFO - Downloading blessings-1.6.tar.gz 11:13:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:13:11 INFO - Installing collected packages: blessings 11:13:11 INFO - Running setup.py install for blessings 11:13:11 INFO - Successfully installed blessings 11:13:11 INFO - Cleaning up... 11:13:11 INFO - Return code: 0 11:13:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:13:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:13:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:13:11 INFO - Reading from file tmpfile_stdout 11:13:11 INFO - Current package versions: 11:13:11 INFO - argparse == 1.2.1 11:13:11 INFO - blessings == 1.6 11:13:11 INFO - blobuploader == 1.2.4 11:13:11 INFO - docopt == 0.6.1 11:13:11 INFO - functools32 == 3.2.3-2 11:13:11 INFO - jsonschema == 2.5.1 11:13:11 INFO - manifestparser == 1.1 11:13:11 INFO - mozInstall == 1.13 11:13:11 INFO - mozcrash == 1.0 11:13:11 INFO - mozdebug == 0.1 11:13:11 INFO - mozdevice == 0.51 11:13:11 INFO - mozfile == 1.2 11:13:11 INFO - mozhttpd == 0.7 11:13:11 INFO - mozinfo == 0.10 11:13:11 INFO - mozleak == 0.1 11:13:11 INFO - mozlog == 3.5 11:13:11 INFO - moznetwork == 0.27 11:13:11 INFO - mozprocess == 0.25 11:13:11 INFO - mozprofile == 0.28 11:13:11 INFO - mozrunner == 6.13 11:13:11 INFO - mozscreenshot == 0.1 11:13:11 INFO - mozsystemmonitor == 0.3 11:13:11 INFO - moztest == 0.8 11:13:11 INFO - mozversion == 1.4 11:13:11 INFO - psutil == 3.1.1 11:13:11 INFO - requests == 1.2.3 11:13:11 INFO - wsgiref == 0.1.2 11:13:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:13: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')]} 11:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13: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')]} 11:13:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:11 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 0x214b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2314a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bb090>, '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 0x24bbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b5f90>, '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': '438111f3d31ce799eff2119d000001bc-1505584246.40180-676488900', '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 11:13:11 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 11:13:11 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 11:13:11 INFO - Using env: {'DISPLAY': ':0', 11:13:11 INFO - 'HOME': '/home/cltbld', 11:13:11 INFO - 'LANG': 'en_US.UTF-8', 11:13:11 INFO - 'LANGUAGE': 'en_US:en', 11:13:11 INFO - 'LOGNAME': 'cltbld', 11:13:11 INFO - 'MAIL': '/var/mail/cltbld', 11:13:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:11 INFO - 'MOZ_NO_REMOTE': '1', 11:13:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:11 INFO - 'NO_EM_RESTART': '1', 11:13:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:11 INFO - 'PWD': '/builds/slave/test', 11:13:11 INFO - 'SHELL': '/bin/bash', 11:13:11 INFO - 'SHLVL': '1', 11:13:11 INFO - 'TERM': 'linux', 11:13:11 INFO - 'TMOUT': '86400', 11:13:11 INFO - 'USER': 'cltbld', 11:13:11 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1505584246.40180-676488900', 11:13:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:11 INFO - '_': '/tools/buildbot/bin/python'} 11:13:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:11 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)) 11:13:11 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)) 11:13:11 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)) 11:13:11 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)) 11:13:11 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)) 11:13:11 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)) 11:13:11 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)) 11:13:11 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)) 11:13:11 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)) 11:13:11 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:13:12 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)) 11:13:12 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)) 11:13:12 INFO - Installing collected packages: simplejson 11:13:12 INFO - Running setup.py install for simplejson 11:13:13 INFO - building 'simplejson._speedups' extension 11:13:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 11:13:13 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 11:13:13 INFO - Successfully installed simplejson 11:13:13 INFO - Cleaning up... 11:13:14 INFO - Return code: 0 11:13:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:13: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')]} 11:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13: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')]} 11:13:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x214b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2314a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bb090>, '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 0x24bbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b5f90>, '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': '438111f3d31ce799eff2119d000001bc-1505584246.40180-676488900', '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 11:13:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:13:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:13:14 INFO - Using env: {'DISPLAY': ':0', 11:13:14 INFO - 'HOME': '/home/cltbld', 11:13:14 INFO - 'LANG': 'en_US.UTF-8', 11:13:14 INFO - 'LANGUAGE': 'en_US:en', 11:13:14 INFO - 'LOGNAME': 'cltbld', 11:13:14 INFO - 'MAIL': '/var/mail/cltbld', 11:13:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:14 INFO - 'MOZ_NO_REMOTE': '1', 11:13:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:14 INFO - 'NO_EM_RESTART': '1', 11:13:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:14 INFO - 'PWD': '/builds/slave/test', 11:13:14 INFO - 'SHELL': '/bin/bash', 11:13:14 INFO - 'SHLVL': '1', 11:13:14 INFO - 'TERM': 'linux', 11:13:14 INFO - 'TMOUT': '86400', 11:13:14 INFO - 'USER': 'cltbld', 11:13:14 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1505584246.40180-676488900', 11:13:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:14 INFO - '_': '/tools/buildbot/bin/python'} 11:13:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:13:14 INFO - Cleaning up... 11:13:14 INFO - Return code: 0 11:13:14 INFO - Running post-action listener: _resource_record_post_action 11:13:14 INFO - Running post-action listener: _start_resource_monitoring 11:13:14 INFO - Starting resource monitoring. 11:13:14 INFO - [mozharness: 2017-09-16 18:13:14.292422Z] Finished create-virtualenv step (success) 11:13:14 INFO - [mozharness: 2017-09-16 18:13:14.292936Z] Running install step. 11:13:14 INFO - Running pre-action listener: _resource_record_pre_action 11:13:14 INFO - Running main action method: install 11:13:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:13:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:13:14 INFO - Reading from file tmpfile_stdout 11:13:14 INFO - Detecting whether we're running mozinstall >=1.0... 11:13:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:13:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:13:14 INFO - Reading from file tmpfile_stdout 11:13:14 INFO - Output received: 11:13:14 INFO - Usage: mozinstall [options] installer 11:13:14 INFO - Options: 11:13:14 INFO - -h, --help show this help message and exit 11:13:14 INFO - -d DEST, --destination=DEST 11:13:14 INFO - Directory to install application into. [default: 11:13:14 INFO - "/builds/slave/test"] 11:13:14 INFO - --app=APP Application being installed. [default: firefox] 11:13:14 INFO - mkdir: /builds/slave/test/build/application 11:13:14 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'] 11:13:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:13:32 INFO - Reading from file tmpfile_stdout 11:13:32 INFO - Output received: 11:13:32 INFO - /builds/slave/test/build/application/firefox/firefox 11:13:32 INFO - Running post-action listener: _resource_record_post_action 11:13:32 INFO - [mozharness: 2017-09-16 18:13:32.833087Z] Finished install step (success) 11:13:32 INFO - [mozharness: 2017-09-16 18:13:32.833429Z] Running setup-mitmproxy step. 11:13:32 INFO - Running pre-action listener: _resource_record_pre_action 11:13:32 INFO - Running main action method: setup_mitmproxy 11:13:32 INFO - Skipping: mitmproxy is not required 11:13:32 INFO - Running post-action listener: _resource_record_post_action 11:13:32 INFO - [mozharness: 2017-09-16 18:13:32.835177Z] Finished setup-mitmproxy step (success) 11:13:32 INFO - [mozharness: 2017-09-16 18:13:32.835489Z] Running run-tests step. 11:13:32 INFO - Running pre-action listener: _resource_record_pre_action 11:13:32 INFO - Running pre-action listener: _set_gcov_prefix 11:13:32 INFO - Running main action method: run_tests 11:13:32 WARNING - Try message not found. 11:13:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:13:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:13:32 INFO - Python 2.7.3 11:13:32 INFO - Return code: 0 11:13:32 INFO - grabbing minidump binary from tooltool 11:13:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:32 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bb090>, '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 0x24bbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b5f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:13:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:13:32 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:13:32 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:13:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:13:32 INFO - Return code: 0 11:13:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:13:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:13:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:13:32 INFO - ENV: RUST_BACKTRACE is now full 11:13:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:13:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:13:32 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/MWFstPgVRxqTsnauXlFVFQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-086', '--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 11:13:32 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/MWFstPgVRxqTsnauXlFVFQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-086 --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 11:13:32 INFO - Using env: {'DISPLAY': ':0', 11:13:32 INFO - 'HOME': '/home/cltbld', 11:13:32 INFO - 'LANG': 'en_US.UTF-8', 11:13:32 INFO - 'LANGUAGE': 'en_US:en', 11:13:32 INFO - 'LOGNAME': 'cltbld', 11:13:32 INFO - 'MAIL': '/var/mail/cltbld', 11:13:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:13:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:13:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:32 INFO - 'MOZ_NO_REMOTE': '1', 11:13:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:13:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:32 INFO - 'NO_EM_RESTART': '1', 11:13:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:32 INFO - 'PWD': '/builds/slave/test', 11:13:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:13:32 INFO - 'RUST_BACKTRACE': 'full', 11:13:32 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:13:32 INFO - 'SHELL': '/bin/bash', 11:13:32 INFO - 'SHLVL': '1', 11:13:32 INFO - 'TERM': 'linux', 11:13:32 INFO - 'TMOUT': '86400', 11:13:32 INFO - 'USER': 'cltbld', 11:13:32 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1505584246.40180-676488900', 11:13:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:32 INFO - '_': '/tools/buildbot/bin/python'} 11:13:32 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/MWFstPgVRxqTsnauXlFVFQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-086', '--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 11:13:33 INFO - mozversion application_buildid: 20170916172404 11:13:33 INFO - mozversion application_changeset: 34e2566a71f160eb3c5c3d92626453852e818f18 11:13:33 INFO - mozversion application_display_name: Nightly 11:13:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:13:33 INFO - mozversion application_name: Firefox 11:13:33 INFO - mozversion application_remotingname: firefox 11:13:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:13:33 INFO - mozversion application_vendor: Mozilla 11:13:33 INFO - mozversion application_version: 57.0a1 11:13:33 INFO - mozversion platform_buildid: 20170916172404 11:13:33 INFO - mozversion platform_changeset: 34e2566a71f160eb3c5c3d92626453852e818f18 11:13:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:13:33 INFO - mozversion platform_version: 57.0a1 11:13:33 INFO - using testdate: 1505585613 11:13:33 INFO - actual date: 1505585613 11:13:33 INFO - starting webserver on 'localhost:58991' 11:13:33 INFO - SUITE-START | Running 2 tests 11:13:33 INFO - TEST-START | dromaeo_css 11:13:33 INFO - Initialising browser for dromaeo_css test... 11:13:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58991/getInfo.html -profile /tmp/tmpCElIoO/profile 11:13:33 INFO - TEST-INFO | started process 23111 (/builds/slave/test/build/application/firefox/firefox http://localhost:58991/getInfo.html) 11:13:38 INFO - TEST-INFO | 23111: exit 0 11:13:38 INFO - Browser initialized. 11:13:38 INFO - Running cycle 1/1 for dromaeo_css test... 11:13:38 INFO - Using env: {'DISPLAY': ':0', 11:13:38 INFO - 'HOME': '/home/cltbld', 11:13:38 INFO - 'JSGC_DISABLE_POISONING': '1', 11:13:38 INFO - 'LANG': 'en_US.UTF-8', 11:13:38 INFO - 'LANGUAGE': 'en_US:en', 11:13:38 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:13:38 INFO - 'LOGNAME': 'cltbld', 11:13:38 INFO - 'MAIL': '/var/mail/cltbld', 11:13:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:13:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:13:38 INFO - 'MOZ_CRASHREPORTER': '1', 11:13:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:38 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:13:38 INFO - 'MOZ_NO_REMOTE': '1', 11:13:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:13:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:38 INFO - 'NO_EM_RESTART': '1', 11:13:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:38 INFO - 'PWD': '/builds/slave/test', 11:13:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:13:38 INFO - 'RUST_BACKTRACE': 'full', 11:13:38 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:13:38 INFO - 'SHELL': '/bin/bash', 11:13:38 INFO - 'SHLVL': '1', 11:13:38 INFO - 'TERM': 'linux', 11:13:38 INFO - 'TMOUT': '86400', 11:13:38 INFO - 'USER': 'cltbld', 11:13:38 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1505584246.40180-676488900', 11:13:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:38 INFO - '_': '/tools/buildbot/bin/python'} 11:13:38 INFO - TEST-INFO | started process 23339 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCElIoO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:13:39 INFO - PID 23339 | 11:13:39 INFO - PID 23339 | (/builds/slave/test/build/application/firefox/firefox:23388): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:13:39 INFO - PID 23339 | 11:13:49 INFO - PID 23339 | RSS: Main: 157175808 11:13:49 INFO - PID 23339 | 11:16:46 INFO - PID 23339 | Cycle 1(1): loaded http://localhost:58991/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58991/tests/dromaeo/cssquery-ext.html) 11:16:48 INFO - PID 23339 | RSS: Main: 155918336 11:16:48 INFO - PID 23339 | 11:19:50 INFO - PID 23339 | Cycle 1(1): loaded http://localhost:58991/tests/dromaeo/cssquery-ext.html (next: http://localhost:58991/tests/dromaeo/cssquery-jquery.html) 11:19:50 INFO - PID 23339 | RSS: Main: 156053504 11:19:50 INFO - PID 23339 | 11:22:52 INFO - PID 23339 | Cycle 1(1): loaded http://localhost:58991/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58991/tests/dromaeo/cssquery-mootools.html) 11:22:53 INFO - PID 23339 | RSS: Main: 158474240 11:22:53 INFO - PID 23339 | 11:25:54 INFO - PID 23339 | Cycle 1(1): loaded http://localhost:58991/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58991/tests/dromaeo/cssquery-prototype.html) 11:25:55 INFO - PID 23339 | RSS: Main: 155017216 11:25:55 INFO - PID 23339 | 11:28:58 INFO - PID 23339 | Cycle 1(1): loaded http://localhost:58991/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58991/tests/dromaeo/cssquery-yui.html) 11:28:59 INFO - PID 23339 | RSS: Main: 155967488 11:28:59 INFO - PID 23339 | 11:32:00 INFO - PID 23339 | Cycle 1(1): loaded http://localhost:58991/tests/dromaeo/cssquery-yui.html (next: http://localhost:58991/tests/dromaeo/cssquery-dojo.html) 11:32:01 INFO - PID 23339 | RSS: Main: 160854016 11:32:01 INFO - PID 23339 | 11:32:01 INFO - PID 23339 | __start_tp_report 11:32:01 INFO - PID 23339 | _x_x_mozilla_page_load 11:32:01 INFO - PID 23339 | _x_x_mozilla_page_load_details 11:32:01 INFO - PID 23339 | |i|pagename|runs| 11:32:01 INFO - PID 23339 | |0;dojo.html;3074.2775447769773;3109.0206584925745;3124.7968882022665;3125.437421264173;3129.0612816155176;6127.448529632332;6178.227721534809;6192.225971753531;6204.96897515513;6265.812025639227;6175.135481032659;6214.316425193225;6237.656928868911;6256.0303153011355;6325.272593651732;5753.5397168226655;5798.507126894208;5828.242328497289;5883.88232235355;5885.735141918624;5522.22688823565;5713.17159011943;5779.508741756956;5798;5842.44496772808;5717.828465146053;5767.45209205127;5813.157092221604;5832.154337621042;5857;5572.3034620672415;5654.236678048452;5655.434456554352;5739.483446489836;5811.302643682785;5734.795692904495;5736.8852622947725;5739.426057394269;5741.971290143522;5755.366909639936;6169.5064394848305;6203.565750397474;6215.34738852423;6244.781432649836;6249.500039996835;6656.56732312403;6677.065210870482;6746.460283177334;6747.831304217385;6754.493412994045;6521.347865213441;6624.635645039521;6655.101561289261;6720.193576770819;6803.387695107464;6054.061620448838;6151.507879369685;6164.907526387108;6230.376962303733;6255.093011513305;6822.079019332426;6840.863182736317;6945.409640180641;6963.895541566881;6965.930340696629;6556.311587283267;6556.4427023702565;6621.602703837785;6622.933770662328;6650.135482387259;6679.599224046573;6714.932850671528;6742.696578653972;6794.218664853506;6795.456363490909;6488.740450381932;6529.314421985718;6613.503987200979;6705.4970877184405;6718.395344419026;6740.932590674129;6742.089817874622;6758;6760.256371799098;6800.489963252677;5272.525472707474;5274.182501712241;5343.278657381282;5353.170258609844;5357.223202635674;4600.884977875513;4605.792739326738;4645;4646.3727396801;4662.393888794435;5759.769609215668;5819;5825.300963884276;5838.591298609056;5844.298684157929;6660.600363978177;6680.064790929274;6719.899201511981;6741.52809303344;6771.559848609824;5545.750441230154;5676.375598684142;5768.307803063659;5800;5810.157527158538;5614.1859430382365;5642.6614403135945;5651.9152212716845;5658.490735833795;5674.233978412862;6465.094886715863;6472.935270647234;6473.838154046187;6476.935230647728;6489.870202595922;6648.601083934979;6691.765788197585;6704.99425086241;6758.357955994173;6784.830379240559;6417.908955477486;6423.197100362455;6442.420182183626;6451.806445806634;6514.771982980573;6389.7763578274535;6509.804705858832;6523.151990241238;6531.216254049545;6620.006998950196;6652.767153149616;6667.933320666925;6680.098186744727;6708.83227919306;6725.260221375547;6493.707783149675;6499.6425196612745;6534.934650653433;6538.411542961157;6547.181602299713;6505.739770409131;6508.284088750139;6568.671566421564;6572.737090516517;6625.536212465081;6420.486361091195;6433.871322573429;6502.284748677736;6513.120728701754;6515.478761698958;6410.230772307353;6435.388638079375;6505.73977040932;6506.3493650634555;6530.575512591667;6289.339619339903;6366.395192456709;6380.521460890359;6382.6170429774365;6405.103285539935 11:32:01 INFO - PID 23339 | |1;ext.html;845.2857335551458;876.0538618292245;881.0748713850455;883.7967267528472;884.4207044385929;38294.42558361627;38932.61067389325;41601.16797664045;41621.791891040506;41949.370759438636;38063;38129.61870381295;38168.427473587915;38207.42688859662;38573.228535429276;6942.0975273214535;7062.646867656596;7075.85848283034;7085.362317391434;7094.645267736592;6976.127984002;7037.788866334018;7062.894056589155;7066.929330706678;7068;7047.224805271416;7065.823354416129;7688.538687678729;7888.013998250219;7891.250331218525;7777.961110194469;7781.22187781223;7788.337991270749;7794.922050779476;7796.805079872992;7501.399888008947;7594.31651151399;7697.769066928001;7718.035245594301;7753.069631644239;39101.60898391008;39487.60512394868;39551.20897582032;39554;39656.405153922715;3531.5585551806025;3541.2563361694074;3566.8394922228304;3583.62371950944;3584.8924532264073;31898.681013189802;31999.200019999687;32019.839900800347;32061.198470038435;32177.83911080453;5175;5198.2722418861385;5220.92168617471;5228.346456692913;5278.947210527884;184471.99999999866;184591;185367;185438.07280963645;185737;42046.36930446046;43008.784956075644;48792;49290.75354623204;49380.75309623501;49963.25055124176;51187.488125119016;51333.743331283855;51382;51489;15049.247537623294;15128.621784455476;15130;15154.772678409832;15221.086734795948;12245.938770306091;12393.504259829506;12406.131570789958;12420.378981050912;12464.875351246372;13553.864461355457;13681.863181368259;13690.589282321545;13755.862441375459;13916.443342266197;5612.691301978431;5698.2592263005545;5764.596478246566;5795.159701843209;5796;989.4459102902254;1016.3393794033938;1021.9437930913871;1025.887152413234;1034.9223808214415;22771.544569108857;22959.88520057389;23024.079036838673;23091.307260782203;23178.768212318;1109;1111.3653775358853;1112.671761830262;1130.6834086455806;1131.1177281720272;12133.575324863765;12162.939185304016;12216.083793715507;12320.630381088582;12373;230988;231623;232324;232408;233249;51665.225021624705;52236.738816305675;52304.73847630737;52400.737996310534;52404.47595524072;1437.7124575085024;1486.472302332678;1490.93290801912;1492.5373134328393;1509.8263699674458;22158.224462143746;22178.556428871656;22752.317430477113;22833;23018.309450716504;37765.4335184978;37852;37952.62047379491;37953.2409351817;38009.23981520409;191165;191551;191824;191985;192395;33281.66718332786;33401.66598333986;34075;35742.64257357393;35859.282814343045;45679.543204567526;46764.29853552268;46775.298370523786;46809.297860531435;46937.53062469332;33404.33191336208;33750.66249337475;33785;33878;33923.3215335687;33868;33943.66056339405;34205.14487137841;34264.828675856465;34824.65175348214;38120.809395953955;38174.80912595419;38200.426993595676;38647.42028869513;38695.80652096721;33074.66925330716;33269.334613308085;33311.66688333086;33360.66639333672;34116.829415852764;24078.75921240765;24167.49571312185;24424.90087946011;24525.38686532851;24597.50804983926 11:32:01 INFO - PID 23339 | |2;jquery.html;560.6807698425322;567.7388401335386;571.8684702518424;583.1893667801755;592.5881512348916;22167;22509.774902250974;22881;22896.427589310275;22924.312270631908;25800.35499112523;26070.608940865903;26256.868715656394;26270.6059409109;26293.60559591603;6536.248331441886;6691.297413771557;6692.029655699921;6695.631740254284;6698.531102822804;6381.585196962205;6588.736450541973;6633.668316584176;6650.966745166292;6652.833679158011;6565;6580.934190658104;6592.703328350236;6599.142111525495;6599.571027883197;6559.311272316386;6589.242237142742;6597.373249541286;6597.736090556372;6605.141331626882;6069.666168360738;6076.210092687922;6090.96954515229;6092.329843717188;6101.389861013908;29139.417211655647;29784.10647680573;30201.546976795365;30340.54489182664;30409.23976900573;2045.8465615078928;2079.500919779242;2083.906224219914;2086.749590049204;2090.644590419632;19673.704894426595;20090;20291.28980485676;20328.79671203284;20357.389278321672;2455.3002394317714;2488.340589743719;2525.4949010198034;2551.107112510625;2552.32363423691;129945.35027324897;132024;132849.3357533216;133057.3347133268;141774;14532.927335363256;15013.549593512213;15153.166575838435;15189.924050379677;15328.540143795704;22709.545809084055;23218.187363442197;23237.53524929526;23389.53220935572;23837.880810596183;10434.37393756377;10611.946940265248;10746.516406761715;10759.731006724895;10833.02502774754;9917.404955702681;9956.651517196864;10007.899921000842;10050.798984020279;10077.748056298504;9317.72046838596;9343;9457.621695132118;9569.138777510057;9602.231821454267;2661.3479697473854;2671.7461841125064;2696.8516731579953;2808.845513496777;2886.523723585627;937.5734041011324;960.4765402855461;962.2061799015839;980.4656462228103;999.4203362050139;19613.705794413094;19745.802541974397;19971.20115195405;20144;20300.59398812045;1039.158281791751;1039.5166247694858;1043.7077618266896;1054.8765564673597;1057.8677665291839;10853.620123295805;10954.945225273983;10988.560457581767;10998.285111467729;11148.944255278671;464277;480590;481027;481639;481775;112783;112964;114715;115082.42458787652;116380.8361916387;1150.718074071841;1152.2164927849144;1184.1947475716595;1189.042820529482;1192.6243233381283;17836.19737111859;17871.374501892373;17979.73030404571;18249.72625410593;18251.817481825543;56056.437882879494;56246.71876640591;57048.1442778367;58331.70834145802;58777;67918;68026.319736802;68396.316036839;68611;70117;13326.200427974352;13597.79603305971;13683.24742139192;13688.93155534216;13745.24401157946;22680.206192783175;22872.08511659515;22943.196988105337;23072;23645;18223;18447.815521844608;18479.260829566665;18559.628807423505;18572.907135464236;14873.702525949204;15190.468333608713;15237.542873713806;15829.366825327319;16198.109103999393;16963.83036169672;17187.484375468757;17271.65456690834;19018.809811901705;19054.523636908634;13474.730505390033;13563.38964746569;13580.728385432434;13618.93190534041;13626.795598066235;16850.07324597159;16889.831101688826;17841.910790445963;17930.5517362067;18093.728594071363 11:32:01 INFO - PID 23339 | |3;mootools.html;1324.8079028540863;1380.9585712428625;1383.9584812455623;1395.3441882315308;1401.5865319730678;15118.773218401733;15739.84260157398;15755.291011904463;15772.605684857885;15774.4478943237;15498.225088745574;15550.144742039183;15552.222388880538;15612.843871561281;15632.062076275432;2804.747572718455;2815.5213613685673;2866.2117917572627;2866.7849911256635;2867.956980645292;2752.5045491811566;2786.1084452975056;2797.9720202798017;2803.032953630994;2803.9018634347804;2718.6329845470905;2756.5589505679095;2792.6509186351705;2803.593478945552;2813.9718602813914;2764.6267753853376;2800.7899407544414;2821.633187685588;2841.8721157547857;2842.8720707568104;2549.5283372575946;2712.606672032564;2727.1954773341913;2732.453509298148;2743.369025124213;15393.23033848303;15532.534023979186;15561.37754489819;15565.844341556553;15573.532794016197;7939.920600794034;8279.62741676626;8296.626651800683;8303.211194936472;8306.667733290662;5398.568114550826;5554.777808887639;5676.233708449347;5690.971545142289;5711.314642242916;1900.8194221548931;1957.8140076692691;1976.1502553901817;1978.881267123977;1998.9600207995904;27419.86290068557;27550.173494795188;27651.170464886087;27670.446591068066;27693.446131077468;6743.089682892844;6897.172339319314;6998.160220773438;7119.715211391486;7157.57054576727;17632.55918602045;17704.91147544254;17739.290428382978;17748.55628609269;17753.11234438299;7778.727744528915;8035.758927232192;8040.155783642634;8046.959765201136;8056.879146812803;7276;7379.88930166048;7426.368758655575;7621.237876212445;7629.618519074024;5186.247994040843;5356.437574054746;5363.329583802025;5376.946230537723;5383.488568585978;1528.4421186266932;1537.5541093082882;1541.961450963735;1545.1887758926653;1557.1513525128832;877.0571635491872;882.166352796601;892.0989800301742;902.634433054614;913.3287034029983;7432.516886402366;7514.248575142442;7550.848983020309;7635.389168866477;7780.105287891852;688.7658196213212;725.3218240944733;729.8978143059869;730.8392153726172;742.4394582090595;4760.190767569521;4875.219964805685;5388.865278368072;5389.757460914268;5640.407757185519;21157;21343.78656213449;21571.130771302403;21929.671054934188;22320.665190022162;21166.894165529073;21537.56924861494;21979;22042.779572204392;22090.226842060452;10908.945455272831;11040.779184416428;11133.053690436242;11195.216334856483;11461.369624670722;8789.42868713557;8837.690680826398;8867.157620026088;8904.287656987295;8954.28365730753;18728.719069214247;18861.434156975312;18879.339223127125;19091.522711932314;19134.330298440043;19424.514387140436;19541.70687439718;19595.510112247306;19718.21127154898;19791.40625781229;10557.736056598647;10891;10960.890391096305;10967.451627418437;10970.780584388109;14096.577102686935;14181.787273191117;14378.496752613608;14381.424743010162;14427.49503767363;11464.598739044093;11665.766684666429;11715.882841171479;11887.82168267494;12124.090693198223;11193.72015699614;11283.66149015531;11315.20793544444;11336.489857956576;11569.19015668895;10059.597616095567;10373.844392334271;10422.687319380431;10533;10628.468576570986;7512.624368781649;7531.435142364454;7531.548107113591;7567.394608431202;7806.531608103532;7854.764357069297;7862.2923936845955;8006.519608823489;8040.517568945882;8104.149064348158 11:32:01 INFO - PID 23339 | |4;prototype.html;500.2795973797731;506.2077848167616;523.515747933162;525.4482793067278;526.0767353294967;6163.414475624814;6229.813105606828;6299.968500157504;6308.211473565804;6348.333424990379;6037.184980027695;6106.297775755778;6169.814905552829;6173.969130154343;6215.782447614334;4902.950970490285;4994.200927851544;5010.697218723131;5012.097822391968;5018.824341148061;5020.769911371719;5034.446210916796;5036.647434679574;5041.873953151164;5043.6721613095215;4965.726885021322;4987.700737955734;5010.824621138261;5023.723695196781;5032.716657252414;4964.262508122129;4969.776360063788;4978.850634480953;4980.551750342486;4997.300917688003;4494.213512635309;4524.8190072397065;4531.864044078683;4532.252178390561;4552.954470455319;6113.480354169901;6179.3820617937845;6199.87600247997;6223.222097237845;6225.844353891189;5645.943540564583;5649.180868774005;5661.518770904437;5694.690221249136;5699;6460.709268082901;6500.967495162494;6503.837404064889;6524.608523488606;6630.834229144261;4869.269609558559;4887.291342755316;4911.926321105187;4913.6314776391555;4917.336159618477;6795.422389096932;6845.931540684629;6945.950944471393;6960.686769095403;6961.825954351131;5046.293518907356;5055.115354812893;5065.569426598707;5072.188449848007;5077.593792496591;5067.315912351785;5080.77136528857;5108.131617624938;5136.357955255593;5138;5706.976581510025;5714.399988001283;5732.742026608813;5739.799107031234;5749.597528172988;6270.372962703693;6394.552381333355;6502.187226596676;6553.2136143663065;6581.86836263272;1740.443058221357;1763.8941663499975;1768.3457120865362;1773.512284121851;1773.7162054071546;1097.653113105793;1202.2966564559656;1205.3069485046133;1206.2219868185148;1226.907981901361;5646.3788983212635;5696.860627874442;5708.600397972102;5799.594028417971;5827.35899051104;6666.833329166712;6791.864162716718;6840.9657951710915;6855.5543889647015;6865.828354291183;5635.464630860061;5779.826605201766;5783.479486846204;5797.710114494258;5800.767969281266;3530.4818927861265;3544.8936531904083;3567.983124809417;3577.8926632201074;3598.964010359863;6497.285298617148;6509.349065093453;6537.934620653733;6538;6602.570832895943;6712.731490740413;6808.727650894008;6809.625470599165;6814.557053791487;6855.417289530346;6358.618482891041;6367;6404.679766011681;6437.67811609427;6536.444402225674;6666.033709942576;6726.932730672631;6730.259671436236;6779.118714567075;6791.894512701078;6490.935090649222;6549.181352330958;6714.865702685821;6724.663766811542;6742.898856517254;6300.558960872695;6389.881770690017;6464.030395440722;6478.935210647834;6525.3800888915475;4823.252395878644;4895.33912921751;4947.109520286239;4962.131626965339;4976.278439626161;6595.472362210916;6718.294579069127;6761.492888033516;6774.356436138559;6802.727890884309;6428.517861160338;6557.868542817994;6569.770058048137;6570;6570.310117437792;6491.545591808528;6518.054882041983;6527.706253218522;6585.407313341822;6590.176227971504;6397.488200943821;6421.935780642134;6484.1894763154605;6508.361471299343;6509.7396104155305;6042.305134909541;6470.320616335217;6484.902726459201;6485.77299794505;6527.608343499405;6125.264968203844;6224.408681175281;6241.282252541016;6286.214223222098;6340.1440805490665 11:32:01 INFO - PID 23339 | |5;yui.html;906.5421961909237;921.4931787516864;940.1022023967112;940.9059094090592;946.0114180681187;19701.113449894754;20099.799002009975;20125;20201.797982020176;20260.290889818858;16488.67022659546;16546.66906661866;17151.485455436326;17227.655446891054;17360.218790154442;959.640134949394;973.9074787895139;981.5239608789731;982.8427451607744;985.9063388978036;978.8776402949632;981.4994352880046;985.4038306824375;985.6895078050427;986.1124987511225;994.140068840455;1019.9643012494564;1022.1362948308705;1027.1782573940854;1032.1020711980586;1020.275604320933;1021.0555236406294;1021.4586269277295;1021.6424251511986;1022.4018948914894;724.0876495615562;743.0155044565972;746.70131947221;749.6176949755609;750.3134631811886;18773.436796896116;18961.43115706531;19208.903955480135;19273;19289.324873629357;18820.153093110843;18988.335408260784;19211.423657290303;19693.606127877363;19787.802121978882;17566.736498952527;17599.64800703979;17723;17729.113544322732;17887.910560447246;3761.717871159674;3773.962160405883;3777.0368556018316;3786.583475817658;3801.9429708554394;104567.47716261446;135218;143248.2837585816;144409;145442.27278863644;17213.483595492155;17864.106794660474;17864.91067544654;17870.123637017925;17889.19498622565;31732.206694832814;32154.517682234786;32169.51745723816;32268.031959041266;32443.18892027671;9203.309751768644;9322.25421966241;9382.390144640576;9417.90582094184;9488.383255088396;4365.061511774984;4459.241928872099;4467.776611169428;4470.441194850644;4474.6867719259335;5531.6957567333375;5567;5635.9436405635415;5644.85887852807;5655.660660360391;1086.896744809242;1111.127764704703;1114.9554017839357;1115.1134847796022;1116.7264020315074;690.823839920827;692.0415224913531;692.9916970807463;703.2580627438;720.0675125712215;12095.153339266168;12381.938090309492;12413.503459861686;12438.129330946927;12825.486980520862;695.2873304862557;695.4123765418213;709.6451774112943;713.5611598866764;718.2888939949516;5865.002949498596;5913.349531551526;5933.465988061095;5934.851628709317;5960.672163031075;121794;123616.38191808983;124539;125313;128560;105026.47486762518;105279;106350;108464.45767771268;109489.45255273672;94854.5257273723;96577.5171124154;96971;97879;101374;12037.518499259932;12039.157258991787;12167.634970950885;12309.276701261651;12362;44388.556114439736;45229.77385113185;45586.08827823358;46670.29994550016;47023.52976470192;55981.72009140091;58746.70626646839;59166.11250831155;59281;59670.70164649149;18794.906025470333;19137;19161;19301.4209573713;19329.226830926604;21129.577408452053;21436;21628.567428651026;22175.445613859138;22194.667079994135;16501.174941253128;16533.83466165371;16640.75038874442;16784.32862685479;16814;17966.730499042264;18223.908880455514;18254.72617910706;18273.543161421072;18497.630047399245;18345.54136146607;18436.446906592824;18637.90681046586;18706.906465467586;18753;13528.729425411633;13867;13943.30283485842;14033.859661403256;14068.859311406755;13626.454941802613;13661;13818.309084545934;13823.447062117402;13921.234332111831 11:32:01 INFO - PID 23339 | __end_tp_report 11:32:01 INFO - PID 23339 | __start_cc_report 11:32:01 INFO - PID 23339 | _x_x_mozilla_cycle_collect,295 11:32:01 INFO - PID 23339 | __end_cc_report 11:32:01 INFO - PID 23339 | __startTimestamp1505586721167__endTimestamp 11:32:01 INFO - PID 23339 | 11:32:01 INFO - PID 23339 | ------- Summary: start ------- 11:32:01 INFO - PID 23339 | Number of tests: 6 11:32:01 INFO - PID 23339 | 11:32:01 INFO - PID 23339 | [#0] dojo.html Cycles:165 Average:6146.25 Median:6417.91 stddev:736.38 (11.5%) stddev-sans-first:698.09 11:32:01 INFO - PID 23339 | Values: 3074.3 3109.0 3124.8 3125.4 3129.1 6127.4 6178.2 6192.2 6205.0 6265.8 6175.1 6214.3 6237.7 6256.0 6325.3 5753.5 5798.5 5828.2 5883.9 5885.7 5522.2 5713.2 5779.5 5798.0 5842.4 5717.8 5767.5 5813.2 5832.2 5857.0 5572.3 5654.2 5655.4 5739.5 5811.3 5734.8 5736.9 5739.4 5742.0 5755.4 6169.5 6203.6 6215.3 6244.8 6249.5 6656.6 6677.1 6746.5 6747.8 6754.5 6521.3 6624.6 6655.1 6720.2 6803.4 6054.1 6151.5 6164.9 6230.4 6255.1 6822.1 6840.9 6945.4 6963.9 6965.9 6556.3 6556.4 6621.6 6622.9 6650.1 6679.6 6714.9 6742.7 6794.2 6795.5 6488.7 6529.3 6613.5 6705.5 6718.4 6740.9 6742.1 6758.0 6760.3 6800.5 5272.5 5274.2 5343.3 5353.2 5357.2 4600.9 4605.8 4645.0 4646.4 4662.4 5759.8 5819.0 5825.3 5838.6 5844.3 6660.6 6680.1 6719.9 6741.5 6771.6 5545.8 5676.4 5768.3 5800.0 5810.2 5614.2 5642.7 5651.9 5658.5 5674.2 6465.1 6472.9 6473.8 6476.9 6489.9 6648.6 6691.8 6705.0 6758.4 6784.8 6417.9 6423.2 6442.4 6451.8 6514.8 6389.8 6509.8 6523.2 6531.2 6620.0 6652.8 6667.9 6680.1 6708.8 6725.3 6493.7 6499.6 6534.9 6538.4 6547.2 6505.7 6508.3 6568.7 6572.7 6625.5 6420.5 6433.9 6502.3 6513.1 6515.5 6410.2 6435.4 6505.7 6506.3 6530.6 6289.3 6366.4 6380.5 6382.6 6405.1 11:32:01 INFO - PID 23339 | 11:32:01 INFO - PID 23339 | [#1] ext.html Cycles:180 Average:37423.42 Median:19663.13 stddev:52880.74 (268.9%) stddev-sans-first:52957.76 11:32:01 INFO - PID 23339 | Values: 845.3 876.1 881.1 883.8 884.4 38294.4 38932.6 41601.2 41621.8 41949.4 38063.0 38129.6 38168.4 38207.4 38573.2 6942.1 7062.6 7075.9 7085.4 7094.6 6976.1 7037.8 7062.9 7066.9 7068.0 7047.2 7065.8 7688.5 7888.0 7891.3 7778.0 7781.2 7788.3 7794.9 7796.8 7501.4 7594.3 7697.8 7718.0 7753.1 39101.6 39487.6 39551.2 39554.0 39656.4 3531.6 3541.3 3566.8 3583.6 3584.9 31898.7 31999.2 32019.8 32061.2 32177.8 5175.0 5198.3 5220.9 5228.3 5278.9 184472.0 184591.0 185367.0 185438.1 185737.0 42046.4 43008.8 48792.0 49290.8 49380.8 49963.3 51187.5 51333.7 51382.0 51489.0 15049.2 15128.6 15130.0 15154.8 15221.1 12245.9 12393.5 12406.1 12420.4 12464.9 13553.9 13681.9 13690.6 13755.9 13916.4 5612.7 5698.3 5764.6 5795.2 5796.0 989.4 1016.3 1021.9 1025.9 1034.9 22771.5 22959.9 23024.1 23091.3 23178.8 1109.0 1111.4 1112.7 1130.7 1131.1 12133.6 12162.9 12216.1 12320.6 12373.0 230988.0 231623.0 232324.0 232408.0 233249.0 51665.2 52236.7 52304.7 52400.7 52404.5 1437.7 1486.5 1490.9 1492.5 1509.8 22158.2 22178.6 22752.3 22833.0 23018.3 37765.4 37852.0 37952.6 37953.2 38009.2 191165.0 191551.0 191824.0 191985.0 192395.0 33281.7 33401.7 34075.0 35742.6 35859.3 45679.5 46764.3 46775.3 46809.3 46937.5 33404.3 33750.7 33785.0 33878.0 33923.3 33868.0 33943.7 34205.1 34264.8 34824.7 38120.8 38174.8 38200.4 38647.4 38695.8 33074.7 33269.3 33311.7 33360.7 34116.8 24078.8 24167.5 24424.9 24525.4 24597.5 11:32:01 INFO - PID 23339 | 11:32:01 INFO - PID 23339 | [#2] jquery.html Cycles:180 Average:34212.11 Median:22694.88 stddev:80510.60 (354.8%) stddev-sans-first:80696.81 11:32:01 INFO - PID 23339 | Values: 560.7 567.7 571.9 583.2 592.6 22167.0 22509.8 22881.0 22896.4 22924.3 25800.4 26070.6 26256.9 26270.6 26293.6 6536.2 6691.3 6692.0 6695.6 6698.5 6381.6 6588.7 6633.7 6651.0 6652.8 6565.0 6580.9 6592.7 6599.1 6599.6 6559.3 6589.2 6597.4 6597.7 6605.1 6069.7 6076.2 6091.0 6092.3 6101.4 29139.4 29784.1 30201.5 30340.5 30409.2 2045.8 2079.5 2083.9 2086.7 2090.6 19673.7 20090.0 20291.3 20328.8 20357.4 2455.3 2488.3 2525.5 2551.1 2552.3 129945.4 132024.0 132849.3 133057.3 141774.0 14532.9 15013.5 15153.2 15189.9 15328.5 22709.5 23218.2 23237.5 23389.5 23837.9 10434.4 10611.9 10746.5 10759.7 10833.0 9917.4 9956.7 10007.9 10050.8 10077.7 9317.7 9343.0 9457.6 9569.1 9602.2 2661.3 2671.7 2696.9 2808.8 2886.5 937.6 960.5 962.2 980.5 999.4 19613.7 19745.8 19971.2 20144.0 20300.6 1039.2 1039.5 1043.7 1054.9 1057.9 10853.6 10954.9 10988.6 10998.3 11148.9 464277.0 480590.0 481027.0 481639.0 481775.0 112783.0 112964.0 114715.0 115082.4 116380.8 1150.7 1152.2 1184.2 1189.0 1192.6 17836.2 17871.4 17979.7 18249.7 18251.8 56056.4 56246.7 57048.1 58331.7 58777.0 67918.0 68026.3 68396.3 68611.0 70117.0 13326.2 13597.8 13683.2 13688.9 13745.2 22680.2 22872.1 22943.2 23072.0 23645.0 18223.0 18447.8 18479.3 18559.6 18572.9 14873.7 15190.5 15237.5 15829.4 16198.1 16963.8 17187.5 17271.7 19018.8 19054.5 13474.7 13563.4 13580.7 13618.9 13626.8 16850.1 16889.8 17841.9 17930.6 18093.7 11:32:01 INFO - PID 23339 | 11:32:01 INFO - PID 23339 | [#3] mootools.html Cycles:180 Average:9530.44 Median:15081.62 stddev:6832.76 (45.3%) stddev-sans-first:6824.11 11:32:01 INFO - PID 23339 | Values: 1324.8 1381.0 1384.0 1395.3 1401.6 15118.8 15739.8 15755.3 15772.6 15774.4 15498.2 15550.1 15552.2 15612.8 15632.1 2804.7 2815.5 2866.2 2866.8 2868.0 2752.5 2786.1 2798.0 2803.0 2803.9 2718.6 2756.6 2792.7 2803.6 2814.0 2764.6 2800.8 2821.6 2841.9 2842.9 2549.5 2712.6 2727.2 2732.5 2743.4 15393.2 15532.5 15561.4 15565.8 15573.5 7939.9 8279.6 8296.6 8303.2 8306.7 5398.6 5554.8 5676.2 5691.0 5711.3 1900.8 1957.8 1976.2 1978.9 1999.0 27419.9 27550.2 27651.2 27670.4 27693.4 6743.1 6897.2 6998.2 7119.7 7157.6 17632.6 17704.9 17739.3 17748.6 17753.1 7778.7 8035.8 8040.2 8047.0 8056.9 7276.0 7379.9 7426.4 7621.2 7629.6 5186.2 5356.4 5363.3 5376.9 5383.5 1528.4 1537.6 1542.0 1545.2 1557.2 877.1 882.2 892.1 902.6 913.3 7432.5 7514.2 7550.8 7635.4 7780.1 688.8 725.3 729.9 730.8 742.4 4760.2 4875.2 5388.9 5389.8 5640.4 21157.0 21343.8 21571.1 21929.7 22320.7 21166.9 21537.6 21979.0 22042.8 22090.2 10908.9 11040.8 11133.1 11195.2 11461.4 8789.4 8837.7 8867.2 8904.3 8954.3 18728.7 18861.4 18879.3 19091.5 19134.3 19424.5 19541.7 19595.5 19718.2 19791.4 10557.7 10891.0 10960.9 10967.5 10970.8 14096.6 14181.8 14378.5 14381.4 14427.5 11464.6 11665.8 11715.9 11887.8 12124.1 11193.7 11283.7 11315.2 11336.5 11569.2 10059.6 10373.8 10422.7 10533.0 10628.5 7512.6 7531.4 7531.5 7567.4 7806.5 7854.8 7862.3 8006.5 8040.5 8104.1 11:32:01 INFO - PID 23339 | 11:32:01 INFO - PID 23339 | [#4] prototype.html Cycles:180 Average:5506.51 Median:6166.61 stddev:1539.77 (25.0%) stddev-sans-first:1497.54 11:32:01 INFO - PID 23339 | Values: 500.3 506.2 523.5 525.4 526.1 6163.4 6229.8 6300.0 6308.2 6348.3 6037.2 6106.3 6169.8 6174.0 6215.8 4903.0 4994.2 5010.7 5012.1 5018.8 5020.8 5034.4 5036.6 5041.9 5043.7 4965.7 4987.7 5010.8 5023.7 5032.7 4964.3 4969.8 4978.9 4980.6 4997.3 4494.2 4524.8 4531.9 4532.3 4553.0 6113.5 6179.4 6199.9 6223.2 6225.8 5645.9 5649.2 5661.5 5694.7 5699.0 6460.7 6501.0 6503.8 6524.6 6630.8 4869.3 4887.3 4911.9 4913.6 4917.3 6795.4 6845.9 6946.0 6960.7 6961.8 5046.3 5055.1 5065.6 5072.2 5077.6 5067.3 5080.8 5108.1 5136.4 5138.0 5707.0 5714.4 5732.7 5739.8 5749.6 6270.4 6394.6 6502.2 6553.2 6581.9 1740.4 1763.9 1768.3 1773.5 1773.7 1097.7 1202.3 1205.3 1206.2 1226.9 5646.4 5696.9 5708.6 5799.6 5827.4 6666.8 6791.9 6841.0 6855.6 6865.8 5635.5 5779.8 5783.5 5797.7 5800.8 3530.5 3544.9 3568.0 3577.9 3599.0 6497.3 6509.3 6537.9 6538.0 6602.6 6712.7 6808.7 6809.6 6814.6 6855.4 6358.6 6367.0 6404.7 6437.7 6536.4 6666.0 6726.9 6730.3 6779.1 6791.9 6490.9 6549.2 6714.9 6724.7 6742.9 6300.6 6389.9 6464.0 6478.9 6525.4 4823.3 4895.3 4947.1 4962.1 4976.3 6595.5 6718.3 6761.5 6774.4 6802.7 6428.5 6557.9 6569.8 6570.0 6570.3 6491.5 6518.1 6527.7 6585.4 6590.2 6397.5 6421.9 6484.2 6508.4 6509.7 6042.3 6470.3 6484.9 6485.8 6527.6 6125.3 6224.4 6241.3 6286.2 6340.1 11:32:01 INFO - PID 23339 | 11:32:01 INFO - PID 23339 | [#5] yui.html Cycles:180 Average:24863.49 Median:19295.37 stddev:35022.70 (181.5%) stddev-sans-first:35074.75 11:32:01 INFO - PID 23339 | Values: 906.5 921.5 940.1 940.9 946.0 19701.1 20099.8 20125.0 20201.8 20260.3 16488.7 16546.7 17151.5 17227.7 17360.2 959.6 973.9 981.5 982.8 985.9 978.9 981.5 985.4 985.7 986.1 994.1 1020.0 1022.1 1027.2 1032.1 1020.3 1021.1 1021.5 1021.6 1022.4 724.1 743.0 746.7 749.6 750.3 18773.4 18961.4 19208.9 19273.0 19289.3 18820.2 18988.3 19211.4 19693.6 19787.8 17566.7 17599.6 17723.0 17729.1 17887.9 3761.7 3774.0 3777.0 3786.6 3801.9 104567.5 135218.0 143248.3 144409.0 145442.3 17213.5 17864.1 17864.9 17870.1 17889.2 31732.2 32154.5 32169.5 32268.0 32443.2 9203.3 9322.3 9382.4 9417.9 9488.4 4365.1 4459.2 4467.8 4470.4 4474.7 5531.7 5567.0 5635.9 5644.9 5655.7 1086.9 1111.1 1115.0 1115.1 1116.7 690.8 692.0 693.0 703.3 720.1 12095.2 12381.9 12413.5 12438.1 12825.5 695.3 695.4 709.6 713.6 718.3 5865.0 5913.3 5933.5 5934.9 5960.7 121794.0 123616.4 124539.0 125313.0 128560.0 105026.5 105279.0 106350.0 108464.5 109489.5 94854.5 96577.5 96971.0 97879.0 101374.0 12037.5 12039.2 12167.6 12309.3 12362.0 44388.6 45229.8 45586.1 46670.3 47023.5 55981.7 58746.7 59166.1 59281.0 59670.7 18794.9 19137.0 19161.0 19301.4 19329.2 21129.6 21436.0 21628.6 22175.4 22194.7 16501.2 16533.8 16640.8 16784.3 16814.0 17966.7 18223.9 18254.7 18273.5 18497.6 18345.5 18436.4 18637.9 18706.9 18753.0 13528.7 13867.0 13943.3 14033.9 14068.9 13626.5 13661.0 13818.3 13823.4 13921.2 11:32:01 INFO - PID 23339 | -------- Summary: end -------- 11:32:01 INFO - PID 23339 | 11:32:01 INFO - TEST-INFO | 23339: exit 0 11:32:01 INFO - TEST-OK | dromaeo_css | took 1108698ms 11:32:01 INFO - TEST-START | kraken 11:32:01 INFO - Initialising browser for kraken test... 11:32:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58991/getInfo.html -profile /tmp/tmpNc5eqf/profile 11:32:01 INFO - TEST-INFO | started process 23721 (/builds/slave/test/build/application/firefox/firefox http://localhost:58991/getInfo.html) 11:32:06 INFO - TEST-INFO | 23721: exit 0 11:32:06 INFO - Browser initialized. 11:32:06 INFO - Running cycle 1/1 for kraken test... 11:32:06 INFO - Using env: {'DISPLAY': ':0', 11:32:06 INFO - 'HOME': '/home/cltbld', 11:32:06 INFO - 'JSGC_DISABLE_POISONING': '1', 11:32:06 INFO - 'LANG': 'en_US.UTF-8', 11:32:06 INFO - 'LANGUAGE': 'en_US:en', 11:32:06 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:32:06 INFO - 'LOGNAME': 'cltbld', 11:32:06 INFO - 'MAIL': '/var/mail/cltbld', 11:32:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:32:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:32:06 INFO - 'MOZ_CRASHREPORTER': '1', 11:32:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:06 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:32:06 INFO - 'MOZ_NO_REMOTE': '1', 11:32:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:32:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:06 INFO - 'NO_EM_RESTART': '1', 11:32:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:06 INFO - 'PWD': '/builds/slave/test', 11:32:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:32:06 INFO - 'RUST_BACKTRACE': 'full', 11:32:06 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:32:06 INFO - 'SHELL': '/bin/bash', 11:32:06 INFO - 'SHLVL': '1', 11:32:06 INFO - 'TERM': 'linux', 11:32:06 INFO - 'TMOUT': '86400', 11:32:06 INFO - 'USER': 'cltbld', 11:32:06 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1505584246.40180-676488900', 11:32:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:06 INFO - '_': '/tools/buildbot/bin/python'} 11:32:06 INFO - TEST-INFO | started process 23950 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNc5eqf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:32:07 INFO - PID 23950 | 11:32:07 INFO - PID 23950 | (/builds/slave/test/build/application/firefox/firefox:23999): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:32:07 INFO - PID 23950 | 11:32:17 INFO - PID 23950 | RSS: Main: 157073408 11:32:17 INFO - PID 23950 | 11:32:20 INFO - PID 23950 | Cycle 1(1): loaded http://localhost:58991/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58991/tests/kraken/driver.html?testName=audio-beat-detection) 11:32:21 INFO - PID 23950 | RSS: Main: 162168832 11:32:21 INFO - PID 23950 | 11:32:24 INFO - PID 23950 | Cycle 1(1): loaded http://localhost:58991/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58991/tests/kraken/driver.html?testName=audio-dft) 11:32:24 INFO - PID 23950 | RSS: Main: 162594816 11:32:24 INFO - PID 23950 | 11:32:27 INFO - PID 23950 | Cycle 1(1): loaded http://localhost:58991/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58991/tests/kraken/driver.html?testName=audio-fft) 11:32:28 INFO - PID 23950 | RSS: Main: 158814208 11:32:28 INFO - PID 23950 | 11:32:30 INFO - PID 23950 | Cycle 1(1): loaded http://localhost:58991/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58991/tests/kraken/driver.html?testName=audio-oscillator) 11:32:31 INFO - PID 23950 | RSS: Main: 159674368 11:32:31 INFO - PID 23950 | 11:32:33 INFO - PID 23950 | Cycle 1(1): loaded http://localhost:58991/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58991/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:32:33 INFO - PID 23950 | RSS: Main: 159981568 11:32:33 INFO - PID 23950 | 11:32:37 INFO - PID 23950 | Cycle 1(1): loaded http://localhost:58991/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58991/tests/kraken/driver.html?testName=imaging-darkroom) 11:32:37 INFO - PID 23950 | RSS: Main: 162201600 11:32:37 INFO - PID 23950 | 11:32:41 INFO - PID 23950 | Cycle 1(1): loaded http://localhost:58991/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58991/tests/kraken/driver.html?testName=imaging-desaturate) 11:32:41 INFO - PID 23950 | RSS: Main: 162254848 11:32:41 INFO - PID 23950 | 11:32:44 INFO - PID 23950 | Cycle 1(1): loaded http://localhost:58991/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58991/tests/kraken/driver.html?testName=json-parse-financial) 11:32:45 INFO - PID 23950 | RSS: Main: 162373632 11:32:45 INFO - PID 23950 | 11:32:47 INFO - PID 23950 | Cycle 1(1): loaded http://localhost:58991/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58991/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:32:47 INFO - PID 23950 | RSS: Main: 162172928 11:32:47 INFO - PID 23950 | 11:32:49 INFO - PID 23950 | Cycle 1(1): loaded http://localhost:58991/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58991/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:32:49 INFO - PID 23950 | RSS: Main: 162566144 11:32:49 INFO - PID 23950 | 11:32:52 INFO - PID 23950 | Cycle 1(1): loaded http://localhost:58991/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58991/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:32:52 INFO - PID 23950 | RSS: Main: 159211520 11:32:52 INFO - PID 23950 | 11:32:55 INFO - PID 23950 | Cycle 1(1): loaded http://localhost:58991/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58991/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:32:55 INFO - PID 23950 | RSS: Main: 159473664 11:32:55 INFO - PID 23950 | 11:32:58 INFO - PID 23950 | Cycle 1(1): loaded http://localhost:58991/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58991/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:32:59 INFO - PID 23950 | RSS: Main: 159703040 11:32:59 INFO - PID 23950 | 11:33:01 INFO - PID 23950 | Cycle 1(1): loaded http://localhost:58991/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58991/tests/kraken/driver.html?testName=ai-astar) 11:33:01 INFO - PID 23950 | RSS: Main: 161026048 11:33:01 INFO - PID 23950 | 11:33:01 INFO - PID 23950 | __start_tp_report 11:33:01 INFO - PID 23950 | _x_x_mozilla_page_load 11:33:01 INFO - PID 23950 | _x_x_mozilla_page_load_details 11:33:01 INFO - PID 23950 | |i|pagename|runs| 11:33:01 INFO - PID 23950 | |0;ai-astar;109;105;108;106;106;113;109;107;107;109 11:33:01 INFO - PID 23950 | |1;audio-beat-detection;118;117;119;116;115;114;119;143;116;117 11:33:01 INFO - PID 23950 | |2;audio-dft;163;163;162;163;174;163;163;170;166;173 11:33:01 INFO - PID 23950 | |3;audio-fft;79;76;74;80;76;76;81;73;74;73 11:33:01 INFO - PID 23950 | |4;audio-oscillator;80;80;80;78;78;78;79;80;131;79 11:33:01 INFO - PID 23950 | |5;imaging-gaussian-blur;114;114;114;113;114;114;111;114;110;113 11:33:01 INFO - PID 23950 | |6;imaging-darkroom;150;148;148;148;149;151;148;149;150;150 11:33:01 INFO - PID 23950 | |7;imaging-desaturate;96;94;95;94;94;95;98;98;94;94 11:33:01 INFO - PID 23950 | |8;json-parse-financial;57;55;54;55;57;53;54;55;56;53 11:33:01 INFO - PID 23950 | |9;json-stringify-tinderbox;38;38;38;38;38;38;37;38;37;38 11:33:01 INFO - PID 23950 | |10;stanford-crypto-aes;80;76;79;73;74;74;74;73;75;73 11:33:01 INFO - PID 23950 | |11;stanford-crypto-ccm;115;115;109;116;116;114;111;113;118;118 11:33:01 INFO - PID 23950 | |12;stanford-crypto-pbkdf2;173;173;176;166;173;178;168;168;174;170 11:33:01 INFO - PID 23950 | |13;stanford-crypto-sha256-iterative;68;65;64;65;64;69;69;69;66;64 11:33:01 INFO - PID 23950 | __end_tp_report 11:33:01 INFO - PID 23950 | __start_cc_report 11:33:01 INFO - PID 23950 | _x_x_mozilla_cycle_collect,775 11:33:01 INFO - PID 23950 | __end_cc_report 11:33:01 INFO - PID 23950 | __startTimestamp1505586781579__endTimestamp 11:33:01 INFO - PID 23950 | 11:33:01 INFO - PID 23950 | ------- Summary: start ------- 11:33:01 INFO - PID 23950 | Number of tests: 14 11:33:01 INFO - PID 23950 | 11:33:01 INFO - PID 23950 | [#0] ai-astar Cycles:10 Average:107.90 Median:108.50 stddev:2.28 (2.1%) stddev-sans-first:2.39 11:33:01 INFO - PID 23950 | Values: 109.0 105.0 108.0 106.0 106.0 113.0 109.0 107.0 107.0 109.0 11:33:01 INFO - PID 23950 | 11:33:01 INFO - PID 23950 | [#1] audio-beat-detection Cycles:10 Average:119.40 Median:117.50 stddev:8.45 (7.2%) stddev-sans-first:8.95 11:33:01 INFO - PID 23950 | Values: 118.0 117.0 119.0 116.0 115.0 114.0 119.0 143.0 116.0 117.0 11:33:01 INFO - PID 23950 | 11:33:01 INFO - PID 23950 | [#2] audio-dft Cycles:10 Average:166.00 Median:164.50 stddev:4.59 (2.8%) stddev-sans-first:4.74 11:33:01 INFO - PID 23950 | Values: 163.0 163.0 162.0 163.0 174.0 163.0 163.0 170.0 166.0 173.0 11:33:01 INFO - PID 23950 | 11:33:01 INFO - PID 23950 | [#3] audio-fft Cycles:10 Average:76.20 Median:76.00 stddev:2.90 (3.8%) stddev-sans-first:2.89 11:33:01 INFO - PID 23950 | Values: 79.0 76.0 74.0 80.0 76.0 76.0 81.0 73.0 74.0 73.0 11:33:01 INFO - PID 23950 | 11:33:01 INFO - PID 23950 | [#4] audio-oscillator Cycles:10 Average:84.30 Median:79.50 stddev:16.43 (20.7%) stddev-sans-first:17.35 11:33:01 INFO - PID 23950 | Values: 80.0 80.0 80.0 78.0 78.0 78.0 79.0 80.0 131.0 79.0 11:33:01 INFO - PID 23950 | 11:33:01 INFO - PID 23950 | [#5] imaging-gaussian-blur Cycles:10 Average:113.10 Median:114.00 stddev:1.45 (1.3%) stddev-sans-first:1.50 11:33:01 INFO - PID 23950 | Values: 114.0 114.0 114.0 113.0 114.0 114.0 111.0 114.0 110.0 113.0 11:33:01 INFO - PID 23950 | 11:33:01 INFO - PID 23950 | [#6] imaging-darkroom Cycles:10 Average:149.10 Median:149.50 stddev:1.10 (0.7%) stddev-sans-first:1.12 11:33:01 INFO - PID 23950 | Values: 150.0 148.0 148.0 148.0 149.0 151.0 148.0 149.0 150.0 150.0 11:33:01 INFO - PID 23950 | 11:33:01 INFO - PID 23950 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:1.62 (1.7%) stddev-sans-first:1.69 11:33:01 INFO - PID 23950 | Values: 96.0 94.0 95.0 94.0 94.0 95.0 98.0 98.0 94.0 94.0 11:33:01 INFO - PID 23950 | 11:33:01 INFO - PID 23950 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:1.45 (2.6%) stddev-sans-first:1.32 11:33:01 INFO - PID 23950 | Values: 57.0 55.0 54.0 55.0 57.0 53.0 54.0 55.0 56.0 53.0 11:33:01 INFO - PID 23950 | 11:33:01 INFO - PID 23950 | [#9] json-stringify-tinderbox Cycles:10 Average:37.80 Median:38.00 stddev:0.42 (1.1%) stddev-sans-first:0.44 11:33:01 INFO - PID 23950 | Values: 38.0 38.0 38.0 38.0 38.0 38.0 37.0 38.0 37.0 38.0 11:33:01 INFO - PID 23950 | 11:33:01 INFO - PID 23950 | [#10] stanford-crypto-aes Cycles:10 Average:75.10 Median:74.50 stddev:2.51 (3.4%) stddev-sans-first:1.94 11:33:01 INFO - PID 23950 | Values: 80.0 76.0 79.0 73.0 74.0 74.0 74.0 73.0 75.0 73.0 11:33:01 INFO - PID 23950 | 11:33:01 INFO - PID 23950 | [#11] stanford-crypto-ccm Cycles:10 Average:114.50 Median:115.50 stddev:2.88 (2.5%) stddev-sans-first:3.05 11:33:01 INFO - PID 23950 | Values: 115.0 115.0 109.0 116.0 116.0 114.0 111.0 113.0 118.0 118.0 11:33:01 INFO - PID 23950 | 11:33:01 INFO - PID 23950 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.90 Median:173.00 stddev:3.81 (2.2%) stddev-sans-first:4.02 11:33:01 INFO - PID 23950 | Values: 173.0 173.0 176.0 166.0 173.0 178.0 168.0 168.0 174.0 170.0 11:33:01 INFO - PID 23950 | 11:33:01 INFO - PID 23950 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:67.00 stddev:2.21 (3.3%) stddev-sans-first:2.26 11:33:01 INFO - PID 23950 | Values: 68.0 65.0 64.0 65.0 64.0 69.0 69.0 69.0 66.0 64.0 11:33:01 INFO - PID 23950 | -------- Summary: end -------- 11:33:01 INFO - PID 23950 | 11:33:01 INFO - PID 23950 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:33:02 INFO - TEST-INFO | 23950: exit 0 11:33:02 INFO - TEST-OK | kraken | took 60358ms 11:33:02 INFO - SUITE-END | took 1169s 11:33:02 INFO - Completed test suite (00:19:29) 11:33:02 INFO - javascript benchmark 11:33:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8573.412050254497, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3074.2775447769773, 3109.0206584925745, 3124.7968882022665, 3125.437421264173, 3129.0612816155176, 6127.448529632332, 6178.227721534809, 6192.225971753531, 6204.96897515513, 6265.812025639227, 6175.135481032659, 6214.316425193225, 6237.656928868911, 6256.0303153011355, 6325.272593651732, 5753.5397168226655, 5798.507126894208, 5828.242328497289, 5883.88232235355, 5885.735141918624, 5522.22688823565, 5713.17159011943, 5779.508741756956, 5798.0, 5842.44496772808, 5717.828465146053, 5767.45209205127, 5813.157092221604, 5832.154337621042, 5857.0, 5572.3034620672415, 5654.236678048452, 5655.434456554352, 5739.483446489836, 5811.302643682785, 5734.795692904495, 5736.8852622947725, 5739.426057394269, 5741.971290143522, 5755.366909639936, 6169.5064394848305, 6203.565750397474, 6215.34738852423, 6244.781432649836, 6249.500039996835, 6656.56732312403, 6677.065210870482, 6746.460283177334, 6747.831304217385, 6754.493412994045, 6521.347865213441, 6624.635645039521, 6655.101561289261, 6720.193576770819, 6803.387695107464, 6054.061620448838, 6151.507879369685, 6164.907526387108, 6230.376962303733, 6255.093011513305, 6822.079019332426, 6840.863182736317, 6945.409640180641, 6963.895541566881, 6965.930340696629, 6556.311587283267, 6556.4427023702565, 6621.602703837785, 6622.933770662328, 6650.135482387259, 6679.599224046573, 6714.932850671528, 6742.696578653972, 6794.218664853506, 6795.456363490909, 6488.740450381932, 6529.314421985718, 6613.503987200979, 6705.4970877184405, 6718.395344419026, 6740.932590674129, 6742.089817874622, 6758.0, 6760.256371799098, 6800.489963252677, 5272.525472707474, 5274.182501712241, 5343.278657381282, 5353.170258609844, 5357.223202635674, 4600.884977875513, 4605.792739326738, 4645.0, 4646.3727396801, 4662.393888794435, 5759.769609215668, 5819.0, 5825.300963884276, 5838.591298609056, 5844.298684157929, 6660.600363978177, 6680.064790929274, 6719.899201511981, 6741.52809303344, 6771.559848609824, 5545.750441230154, 5676.375598684142, 5768.307803063659, 5800.0, 5810.157527158538, 5614.1859430382365, 5642.6614403135945, 5651.9152212716845, 5658.490735833795, 5674.233978412862, 6465.094886715863, 6472.935270647234, 6473.838154046187, 6476.935230647728, 6489.870202595922, 6648.601083934979, 6691.765788197585, 6704.99425086241, 6758.357955994173, 6784.830379240559, 6417.908955477486, 6423.197100362455, 6442.420182183626, 6451.806445806634, 6514.771982980573, 6389.7763578274535, 6509.804705858832, 6523.151990241238, 6531.216254049545, 6620.006998950196, 6652.767153149616, 6667.933320666925, 6680.098186744727, 6708.83227919306, 6725.260221375547, 6493.707783149675, 6499.6425196612745, 6534.934650653433, 6538.411542961157, 6547.181602299713, 6505.739770409131, 6508.284088750139, 6568.671566421564, 6572.737090516517, 6625.536212465081, 6420.486361091195, 6433.871322573429, 6502.284748677736, 6513.120728701754, 6515.478761698958, 6410.230772307353, 6435.388638079375, 6505.73977040932, 6506.3493650634555, 6530.575512591667, 6289.339619339903, 6366.395192456709, 6380.521460890359, 6382.6170429774365, 6405.103285539935], "value": 6089.904011101654, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [845.2857335551458, 876.0538618292245, 881.0748713850455, 883.7967267528472, 884.4207044385929, 38294.42558361627, 38932.61067389325, 41601.16797664045, 41621.791891040506, 41949.370759438636, 38063.0, 38129.61870381295, 38168.427473587915, 38207.42688859662, 38573.228535429276, 6942.0975273214535, 7062.646867656596, 7075.85848283034, 7085.362317391434, 7094.645267736592, 6976.127984002, 7037.788866334018, 7062.894056589155, 7066.929330706678, 7068.0, 7047.224805271416, 7065.823354416129, 7688.538687678729, 7888.013998250219, 7891.250331218525, 7777.961110194469, 7781.22187781223, 7788.337991270749, 7794.922050779476, 7796.805079872992, 7501.399888008947, 7594.31651151399, 7697.769066928001, 7718.035245594301, 7753.069631644239, 39101.60898391008, 39487.60512394868, 39551.20897582032, 39554.0, 39656.405153922715, 3531.5585551806025, 3541.2563361694074, 3566.8394922228304, 3583.62371950944, 3584.8924532264073, 31898.681013189802, 31999.200019999687, 32019.839900800347, 32061.198470038435, 32177.83911080453, 5175.0, 5198.2722418861385, 5220.92168617471, 5228.346456692913, 5278.947210527884, 184471.99999999866, 184591.0, 185367.0, 185438.07280963645, 185737.0, 42046.36930446046, 43008.784956075644, 48792.0, 49290.75354623204, 49380.75309623501, 49963.25055124176, 51187.488125119016, 51333.743331283855, 51382.0, 51489.0, 15049.247537623294, 15128.621784455476, 15130.0, 15154.772678409832, 15221.086734795948, 12245.938770306091, 12393.504259829506, 12406.131570789958, 12420.378981050912, 12464.875351246372, 13553.864461355457, 13681.863181368259, 13690.589282321545, 13755.862441375459, 13916.443342266197, 5612.691301978431, 5698.2592263005545, 5764.596478246566, 5795.159701843209, 5796.0, 989.4459102902254, 1016.3393794033938, 1021.9437930913871, 1025.887152413234, 1034.9223808214415, 22771.544569108857, 22959.88520057389, 23024.079036838673, 23091.307260782203, 23178.768212318, 1109.0, 1111.3653775358853, 1112.671761830262, 1130.6834086455806, 1131.1177281720272, 12133.575324863765, 12162.939185304016, 12216.083793715507, 12320.630381088582, 12373.0, 230988.0, 231623.0, 232324.0, 232408.0, 233249.0, 51665.225021624705, 52236.738816305675, 52304.73847630737, 52400.737996310534, 52404.47595524072, 1437.7124575085024, 1486.472302332678, 1490.93290801912, 1492.5373134328393, 1509.8263699674458, 22158.224462143746, 22178.556428871656, 22752.317430477113, 22833.0, 23018.309450716504, 37765.4335184978, 37852.0, 37952.62047379491, 37953.2409351817, 38009.23981520409, 191165.0, 191551.0, 191824.0, 191985.0, 192395.0, 33281.66718332786, 33401.66598333986, 34075.0, 35742.64257357393, 35859.282814343045, 45679.543204567526, 46764.29853552268, 46775.298370523786, 46809.297860531435, 46937.53062469332, 33404.33191336208, 33750.66249337475, 33785.0, 33878.0, 33923.3215335687, 33868.0, 33943.66056339405, 34205.14487137841, 34264.828675856465, 34824.65175348214, 38120.809395953955, 38174.80912595419, 38200.426993595676, 38647.42028869513, 38695.80652096721, 33074.66925330716, 33269.334613308085, 33311.66688333086, 33360.66639333672, 34116.829415852764, 24078.75921240765, 24167.49571312185, 24424.90087946011, 24525.38686532851, 24597.50804983926], "value": 17115.863305924824, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.6807698425322, 567.7388401335386, 571.8684702518424, 583.1893667801755, 592.5881512348916, 22167.0, 22509.774902250974, 22881.0, 22896.427589310275, 22924.312270631908, 25800.35499112523, 26070.608940865903, 26256.868715656394, 26270.6059409109, 26293.60559591603, 6536.248331441886, 6691.297413771557, 6692.029655699921, 6695.631740254284, 6698.531102822804, 6381.585196962205, 6588.736450541973, 6633.668316584176, 6650.966745166292, 6652.833679158011, 6565.0, 6580.934190658104, 6592.703328350236, 6599.142111525495, 6599.571027883197, 6559.311272316386, 6589.242237142742, 6597.373249541286, 6597.736090556372, 6605.141331626882, 6069.666168360738, 6076.210092687922, 6090.96954515229, 6092.329843717188, 6101.389861013908, 29139.417211655647, 29784.10647680573, 30201.546976795365, 30340.54489182664, 30409.23976900573, 2045.8465615078928, 2079.500919779242, 2083.906224219914, 2086.749590049204, 2090.644590419632, 19673.704894426595, 20090.0, 20291.28980485676, 20328.79671203284, 20357.389278321672, 2455.3002394317714, 2488.340589743719, 2525.4949010198034, 2551.107112510625, 2552.32363423691, 129945.35027324897, 132024.0, 132849.3357533216, 133057.3347133268, 141774.0, 14532.927335363256, 15013.549593512213, 15153.166575838435, 15189.924050379677, 15328.540143795704, 22709.545809084055, 23218.187363442197, 23237.53524929526, 23389.53220935572, 23837.880810596183, 10434.37393756377, 10611.946940265248, 10746.516406761715, 10759.731006724895, 10833.02502774754, 9917.404955702681, 9956.651517196864, 10007.899921000842, 10050.798984020279, 10077.748056298504, 9317.72046838596, 9343.0, 9457.621695132118, 9569.138777510057, 9602.231821454267, 2661.3479697473854, 2671.7461841125064, 2696.8516731579953, 2808.845513496777, 2886.523723585627, 937.5734041011324, 960.4765402855461, 962.2061799015839, 980.4656462228103, 999.4203362050139, 19613.705794413094, 19745.802541974397, 19971.20115195405, 20144.0, 20300.59398812045, 1039.158281791751, 1039.5166247694858, 1043.7077618266896, 1054.8765564673597, 1057.8677665291839, 10853.620123295805, 10954.945225273983, 10988.560457581767, 10998.285111467729, 11148.944255278671, 464277.0, 480590.0, 481027.0, 481639.0, 481775.0, 112783.0, 112964.0, 114715.0, 115082.42458787652, 116380.8361916387, 1150.718074071841, 1152.2164927849144, 1184.1947475716595, 1189.042820529482, 1192.6243233381283, 17836.19737111859, 17871.374501892373, 17979.73030404571, 18249.72625410593, 18251.817481825543, 56056.437882879494, 56246.71876640591, 57048.1442778367, 58331.70834145802, 58777.0, 67918.0, 68026.319736802, 68396.316036839, 68611.0, 70117.0, 13326.200427974352, 13597.79603305971, 13683.24742139192, 13688.93155534216, 13745.24401157946, 22680.206192783175, 22872.08511659515, 22943.196988105337, 23072.0, 23645.0, 18223.0, 18447.815521844608, 18479.260829566665, 18559.628807423505, 18572.907135464236, 14873.702525949204, 15190.468333608713, 15237.542873713806, 15829.366825327319, 16198.109103999393, 16963.83036169672, 17187.484375468757, 17271.65456690834, 19018.809811901705, 19054.523636908634, 13474.730505390033, 13563.38964746569, 13580.728385432434, 13618.93190534041, 13626.795598066235, 16850.07324597159, 16889.831101688826, 17841.910790445963, 17930.5517362067, 18093.728594071363], "value": 11959.315113918368, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1324.8079028540863, 1380.9585712428625, 1383.9584812455623, 1395.3441882315308, 1401.5865319730678, 15118.773218401733, 15739.84260157398, 15755.291011904463, 15772.605684857885, 15774.4478943237, 15498.225088745574, 15550.144742039183, 15552.222388880538, 15612.843871561281, 15632.062076275432, 2804.747572718455, 2815.5213613685673, 2866.2117917572627, 2866.7849911256635, 2867.956980645292, 2752.5045491811566, 2786.1084452975056, 2797.9720202798017, 2803.032953630994, 2803.9018634347804, 2718.6329845470905, 2756.5589505679095, 2792.6509186351705, 2803.593478945552, 2813.9718602813914, 2764.6267753853376, 2800.7899407544414, 2821.633187685588, 2841.8721157547857, 2842.8720707568104, 2549.5283372575946, 2712.606672032564, 2727.1954773341913, 2732.453509298148, 2743.369025124213, 15393.23033848303, 15532.534023979186, 15561.37754489819, 15565.844341556553, 15573.532794016197, 7939.920600794034, 8279.62741676626, 8296.626651800683, 8303.211194936472, 8306.667733290662, 5398.568114550826, 5554.777808887639, 5676.233708449347, 5690.971545142289, 5711.314642242916, 1900.8194221548931, 1957.8140076692691, 1976.1502553901817, 1978.881267123977, 1998.9600207995904, 27419.86290068557, 27550.173494795188, 27651.170464886087, 27670.446591068066, 27693.446131077468, 6743.089682892844, 6897.172339319314, 6998.160220773438, 7119.715211391486, 7157.57054576727, 17632.55918602045, 17704.91147544254, 17739.290428382978, 17748.55628609269, 17753.11234438299, 7778.727744528915, 8035.758927232192, 8040.155783642634, 8046.959765201136, 8056.879146812803, 7276.0, 7379.88930166048, 7426.368758655575, 7621.237876212445, 7629.618519074024, 5186.247994040843, 5356.437574054746, 5363.329583802025, 5376.946230537723, 5383.488568585978, 1528.4421186266932, 1537.5541093082882, 1541.961450963735, 1545.1887758926653, 1557.1513525128832, 877.0571635491872, 882.166352796601, 892.0989800301742, 902.634433054614, 913.3287034029983, 7432.516886402366, 7514.248575142442, 7550.848983020309, 7635.389168866477, 7780.105287891852, 688.7658196213212, 725.3218240944733, 729.8978143059869, 730.8392153726172, 742.4394582090595, 4760.190767569521, 4875.219964805685, 5388.865278368072, 5389.757460914268, 5640.407757185519, 21157.0, 21343.78656213449, 21571.130771302403, 21929.671054934188, 22320.665190022162, 21166.894165529073, 21537.56924861494, 21979.0, 22042.779572204392, 22090.226842060452, 10908.945455272831, 11040.779184416428, 11133.053690436242, 11195.216334856483, 11461.369624670722, 8789.42868713557, 8837.690680826398, 8867.157620026088, 8904.287656987295, 8954.28365730753, 18728.719069214247, 18861.434156975312, 18879.339223127125, 19091.522711932314, 19134.330298440043, 19424.514387140436, 19541.70687439718, 19595.510112247306, 19718.21127154898, 19791.40625781229, 10557.736056598647, 10891.0, 10960.890391096305, 10967.451627418437, 10970.780584388109, 14096.577102686935, 14181.787273191117, 14378.496752613608, 14381.424743010162, 14427.49503767363, 11464.598739044093, 11665.766684666429, 11715.882841171479, 11887.82168267494, 12124.090693198223, 11193.72015699614, 11283.66149015531, 11315.20793544444, 11336.489857956576, 11569.19015668895, 10059.597616095567, 10373.844392334271, 10422.687319380431, 10533.0, 10628.468576570986, 7512.624368781649, 7531.435142364454, 7531.548107113591, 7567.394608431202, 7806.531608103532, 7854.764357069297, 7862.2923936845955, 8006.519608823489, 8040.517568945882, 8104.149064348158], "value": 6762.050495740547, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.2795973797731, 506.2077848167616, 523.515747933162, 525.4482793067278, 526.0767353294967, 6163.414475624814, 6229.813105606828, 6299.968500157504, 6308.211473565804, 6348.333424990379, 6037.184980027695, 6106.297775755778, 6169.814905552829, 6173.969130154343, 6215.782447614334, 4902.950970490285, 4994.200927851544, 5010.697218723131, 5012.097822391968, 5018.824341148061, 5020.769911371719, 5034.446210916796, 5036.647434679574, 5041.873953151164, 5043.6721613095215, 4965.726885021322, 4987.700737955734, 5010.824621138261, 5023.723695196781, 5032.716657252414, 4964.262508122129, 4969.776360063788, 4978.850634480953, 4980.551750342486, 4997.300917688003, 4494.213512635309, 4524.8190072397065, 4531.864044078683, 4532.252178390561, 4552.954470455319, 6113.480354169901, 6179.3820617937845, 6199.87600247997, 6223.222097237845, 6225.844353891189, 5645.943540564583, 5649.180868774005, 5661.518770904437, 5694.690221249136, 5699.0, 6460.709268082901, 6500.967495162494, 6503.837404064889, 6524.608523488606, 6630.834229144261, 4869.269609558559, 4887.291342755316, 4911.926321105187, 4913.6314776391555, 4917.336159618477, 6795.422389096932, 6845.931540684629, 6945.950944471393, 6960.686769095403, 6961.825954351131, 5046.293518907356, 5055.115354812893, 5065.569426598707, 5072.188449848007, 5077.593792496591, 5067.315912351785, 5080.77136528857, 5108.131617624938, 5136.357955255593, 5138.0, 5706.976581510025, 5714.399988001283, 5732.742026608813, 5739.799107031234, 5749.597528172988, 6270.372962703693, 6394.552381333355, 6502.187226596676, 6553.2136143663065, 6581.86836263272, 1740.443058221357, 1763.8941663499975, 1768.3457120865362, 1773.512284121851, 1773.7162054071546, 1097.653113105793, 1202.2966564559656, 1205.3069485046133, 1206.2219868185148, 1226.907981901361, 5646.3788983212635, 5696.860627874442, 5708.600397972102, 5799.594028417971, 5827.35899051104, 6666.833329166712, 6791.864162716718, 6840.9657951710915, 6855.5543889647015, 6865.828354291183, 5635.464630860061, 5779.826605201766, 5783.479486846204, 5797.710114494258, 5800.767969281266, 3530.4818927861265, 3544.8936531904083, 3567.983124809417, 3577.8926632201074, 3598.964010359863, 6497.285298617148, 6509.349065093453, 6537.934620653733, 6538.0, 6602.570832895943, 6712.731490740413, 6808.727650894008, 6809.625470599165, 6814.557053791487, 6855.417289530346, 6358.618482891041, 6367.0, 6404.679766011681, 6437.67811609427, 6536.444402225674, 6666.033709942576, 6726.932730672631, 6730.259671436236, 6779.118714567075, 6791.894512701078, 6490.935090649222, 6549.181352330958, 6714.865702685821, 6724.663766811542, 6742.898856517254, 6300.558960872695, 6389.881770690017, 6464.030395440722, 6478.935210647834, 6525.3800888915475, 4823.252395878644, 4895.33912921751, 4947.109520286239, 4962.131626965339, 4976.278439626161, 6595.472362210916, 6718.294579069127, 6761.492888033516, 6774.356436138559, 6802.727890884309, 6428.517861160338, 6557.868542817994, 6569.770058048137, 6570.0, 6570.310117437792, 6491.545591808528, 6518.054882041983, 6527.706253218522, 6585.407313341822, 6590.176227971504, 6397.488200943821, 6421.935780642134, 6484.1894763154605, 6508.361471299343, 6509.7396104155305, 6042.305134909541, 6470.320616335217, 6484.902726459201, 6485.77299794505, 6527.608343499405, 6125.264968203844, 6224.408681175281, 6241.282252541016, 6286.214223222098, 6340.1440805490665], "value": 5051.940787369075, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [906.5421961909237, 921.4931787516864, 940.1022023967112, 940.9059094090592, 946.0114180681187, 19701.113449894754, 20099.799002009975, 20125.0, 20201.797982020176, 20260.290889818858, 16488.67022659546, 16546.66906661866, 17151.485455436326, 17227.655446891054, 17360.218790154442, 959.640134949394, 973.9074787895139, 981.5239608789731, 982.8427451607744, 985.9063388978036, 978.8776402949632, 981.4994352880046, 985.4038306824375, 985.6895078050427, 986.1124987511225, 994.140068840455, 1019.9643012494564, 1022.1362948308705, 1027.1782573940854, 1032.1020711980586, 1020.275604320933, 1021.0555236406294, 1021.4586269277295, 1021.6424251511986, 1022.4018948914894, 724.0876495615562, 743.0155044565972, 746.70131947221, 749.6176949755609, 750.3134631811886, 18773.436796896116, 18961.43115706531, 19208.903955480135, 19273.0, 19289.324873629357, 18820.153093110843, 18988.335408260784, 19211.423657290303, 19693.606127877363, 19787.802121978882, 17566.736498952527, 17599.64800703979, 17723.0, 17729.113544322732, 17887.910560447246, 3761.717871159674, 3773.962160405883, 3777.0368556018316, 3786.583475817658, 3801.9429708554394, 104567.47716261446, 135218.0, 143248.2837585816, 144409.0, 145442.27278863644, 17213.483595492155, 17864.106794660474, 17864.91067544654, 17870.123637017925, 17889.19498622565, 31732.206694832814, 32154.517682234786, 32169.51745723816, 32268.031959041266, 32443.18892027671, 9203.309751768644, 9322.25421966241, 9382.390144640576, 9417.90582094184, 9488.383255088396, 4365.061511774984, 4459.241928872099, 4467.776611169428, 4470.441194850644, 4474.6867719259335, 5531.6957567333375, 5567.0, 5635.9436405635415, 5644.85887852807, 5655.660660360391, 1086.896744809242, 1111.127764704703, 1114.9554017839357, 1115.1134847796022, 1116.7264020315074, 690.823839920827, 692.0415224913531, 692.9916970807463, 703.2580627438, 720.0675125712215, 12095.153339266168, 12381.938090309492, 12413.503459861686, 12438.129330946927, 12825.486980520862, 695.2873304862557, 695.4123765418213, 709.6451774112943, 713.5611598866764, 718.2888939949516, 5865.002949498596, 5913.349531551526, 5933.465988061095, 5934.851628709317, 5960.672163031075, 121794.0, 123616.38191808983, 124539.0, 125313.0, 128560.0, 105026.47486762518, 105279.0, 106350.0, 108464.45767771268, 109489.45255273672, 94854.5257273723, 96577.5171124154, 96971.0, 97879.0, 101374.0, 12037.518499259932, 12039.157258991787, 12167.634970950885, 12309.276701261651, 12362.0, 44388.556114439736, 45229.77385113185, 45586.08827823358, 46670.29994550016, 47023.52976470192, 55981.72009140091, 58746.70626646839, 59166.11250831155, 59281.0, 59670.70164649149, 18794.906025470333, 19137.0, 19161.0, 19301.4209573713, 19329.226830926604, 21129.577408452053, 21436.0, 21628.567428651026, 22175.445613859138, 22194.667079994135, 16501.174941253128, 16533.83466165371, 16640.75038874442, 16784.32862685479, 16814.0, 17966.730499042264, 18223.908880455514, 18254.72617910706, 18273.543161421072, 18497.630047399245, 18345.54136146607, 18436.446906592824, 18637.90681046586, 18706.906465467586, 18753.0, 13528.729425411633, 13867.0, 13943.30283485842, 14033.859661403256, 14068.859311406755, 13626.454941802613, 13661.0, 13818.309084545934, 13823.447062117402, 13921.234332111831], "value": 9324.898865177976, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1431.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 105.0, 108.0, 106.0, 106.0, 113.0, 109.0, 107.0, 107.0, 109.0], "value": 107.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 119.0, 116.0, 115.0, 114.0, 119.0, 143.0, 116.0, 117.0], "value": 119.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 163.0, 174.0, 163.0, 163.0, 170.0, 166.0, 173.0], "value": 166.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 76.0, 74.0, 80.0, 76.0, 76.0, 81.0, 73.0, 74.0, 73.0], "value": 76.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 80.0, 78.0, 78.0, 78.0, 79.0, 80.0, 131.0, 79.0], "value": 84.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 113.0, 114.0, 114.0, 111.0, 114.0, 110.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 148.0, 148.0, 148.0, 149.0, 151.0, 148.0, 149.0, 150.0, 150.0], "value": 149.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 95.0, 94.0, 94.0, 95.0, 98.0, 98.0, 94.0, 94.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 54.0, 55.0, 57.0, 53.0, 54.0, 55.0, 56.0, 53.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 37.0, 38.0, 37.0, 38.0], "value": 37.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 76.0, 79.0, 73.0, 74.0, 74.0, 74.0, 73.0, 75.0, 73.0], "value": 75.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 109.0, 116.0, 116.0, 114.0, 111.0, 113.0, 118.0, 118.0], "value": 114.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 173.0, 176.0, 166.0, 173.0, 178.0, 168.0, 168.0, 174.0, 170.0], "value": 171.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 64.0, 65.0, 64.0, 69.0, 69.0, 69.0, 66.0, 64.0], "value": 66.3, "unit": "score"}]}]} 11:33:02 INFO - Return code: 0 11:33:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:33:02 INFO - # TBPL SUCCESS # 11:33:02 INFO - Running post-action listener: _package_coverage_data 11:33:02 INFO - Running post-action listener: _resource_record_post_action 11:33:02 INFO - [mozharness: 2017-09-16 18:33:02.865287Z] Finished run-tests step (success) 11:33:02 INFO - Running post-run listener: _resource_record_post_run 11:33:02 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 8192; Write bytes: 341540864; Read time: 160; Write time: 200372 11:33:02 INFO - TinderboxPrint: CPU usage
13.1% 11:33:02 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 160 11:33:02 INFO - TinderboxPrint: I/O write bytes / time
341,540,864 / 200,372 11:33:02 INFO - TinderboxPrint: CPU idle
8,230.7 (86.9%) 11:33:02 INFO - TinderboxPrint: CPU user
1,191.8 (12.6%) 11:33:02 INFO - TinderboxPrint: Swap in / out
0 / 0 11:33:02 INFO - install - Wall time: 19s; CPU: 13.0%; Read bytes: 0; Write bytes: 10059776; Read time: 0; Write time: 960 11:33:02 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:33:02 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 4096; Write bytes: 331481088; Read time: 148; Write time: 199412 11:33:03 INFO - Running post-run listener: _upload_blobber_files 11:33:03 INFO - Blob upload gear active. 11:33:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:33:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:33:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:33:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:33:03 INFO - (blobuploader) - INFO - Open directory for files ... 11:33:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:33:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:33:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:33:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:33:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:33:10 INFO - (blobuploader) - INFO - Done attempting. 11:33:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:33:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:33:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:33:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:33:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:33:11 INFO - (blobuploader) - INFO - Done attempting. 11:33:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:33:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:33:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:33:13 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:33:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:33:13 INFO - (blobuploader) - INFO - Done attempting. 11:33:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:33:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:33:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:33:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:33:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:33:13 INFO - (blobuploader) - INFO - Done attempting. 11:33:13 INFO - (blobuploader) - INFO - Iteration through files over. 11:33:13 INFO - Return code: 0 11:33:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:33:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:33:13 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5747c32cc8bba10d3af6732fa03b725dccf450ef9e0b39b971ae17f0ee5bb068d822aa8628337607d82d522d1f3ff81a48d829fc34b3a0d9f5701aaaca8068a5", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/93dcc72d6ef2a78ecc4ad99dba49d0e4858d8be43b22484c194f866626e2977a175e82a8d3883a52c1e1106d5bca7ece38df06057d2628eaa711d6b5be69793d", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cd559362b74f2a77f5636f3bbb45ad5d14f73b62e42b5869dce8c7b8a07bcf92c9eddfe30645ad9d36b8df3f2fa4347734516e4d9a40c0c4d12c4c41bfa6a0d3", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/238a67174e5d00d87cfcc0e2062bf973c389ddf4c7c0c2475c768a63fbce0ae2796dea9aa9e3516a9fff147bad6d489552a92ff2a807b1e65a45a0bf8c0359ee"} 11:33:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:33:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:33:13 INFO - Contents: 11:33:13 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5747c32cc8bba10d3af6732fa03b725dccf450ef9e0b39b971ae17f0ee5bb068d822aa8628337607d82d522d1f3ff81a48d829fc34b3a0d9f5701aaaca8068a5", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/93dcc72d6ef2a78ecc4ad99dba49d0e4858d8be43b22484c194f866626e2977a175e82a8d3883a52c1e1106d5bca7ece38df06057d2628eaa711d6b5be69793d", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cd559362b74f2a77f5636f3bbb45ad5d14f73b62e42b5869dce8c7b8a07bcf92c9eddfe30645ad9d36b8df3f2fa4347734516e4d9a40c0c4d12c4c41bfa6a0d3", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/238a67174e5d00d87cfcc0e2062bf973c389ddf4c7c0c2475c768a63fbce0ae2796dea9aa9e3516a9fff147bad6d489552a92ff2a807b1e65a45a0bf8c0359ee"} 11:33:13 INFO - Running post-run listener: copy_logs_to_upload_dir 11:33:13 INFO - Copying logs to upload dir... 11:33:13 INFO - mkdir: /builds/slave/test/build/upload/logs 11:33:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.771968 ========= master_lag: 0.84 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-16 11:33:14.790683) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 11:33:14.798772) ========= 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=438111f3d31ce799eff2119d000001bc-1505584246.40180-676488900 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/5747c32cc8bba10d3af6732fa03b725dccf450ef9e0b39b971ae17f0ee5bb068d822aa8628337607d82d522d1f3ff81a48d829fc34b3a0d9f5701aaaca8068a5", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/93dcc72d6ef2a78ecc4ad99dba49d0e4858d8be43b22484c194f866626e2977a175e82a8d3883a52c1e1106d5bca7ece38df06057d2628eaa711d6b5be69793d", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cd559362b74f2a77f5636f3bbb45ad5d14f73b62e42b5869dce8c7b8a07bcf92c9eddfe30645ad9d36b8df3f2fa4347734516e4d9a40c0c4d12c4c41bfa6a0d3", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/238a67174e5d00d87cfcc0e2062bf973c389ddf4c7c0c2475c768a63fbce0ae2796dea9aa9e3516a9fff147bad6d489552a92ff2a807b1e65a45a0bf8c0359ee"} build_url:https://queue.taskcluster.net/v1/task/MWFstPgVRxqTsnauXlFVFQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011236 build_url: 'https://queue.taskcluster.net/v1/task/MWFstPgVRxqTsnauXlFVFQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5747c32cc8bba10d3af6732fa03b725dccf450ef9e0b39b971ae17f0ee5bb068d822aa8628337607d82d522d1f3ff81a48d829fc34b3a0d9f5701aaaca8068a5", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/93dcc72d6ef2a78ecc4ad99dba49d0e4858d8be43b22484c194f866626e2977a175e82a8d3883a52c1e1106d5bca7ece38df06057d2628eaa711d6b5be69793d", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cd559362b74f2a77f5636f3bbb45ad5d14f73b62e42b5869dce8c7b8a07bcf92c9eddfe30645ad9d36b8df3f2fa4347734516e4d9a40c0c4d12c4c41bfa6a0d3", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/238a67174e5d00d87cfcc0e2062bf973c389ddf4c7c0c2475c768a63fbce0ae2796dea9aa9e3516a9fff147bad6d489552a92ff2a807b1e65a45a0bf8c0359ee"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 11:33:14.832804) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 11:33:14.833122) ========= 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=438111f3d31ce799eff2119d000001bc-1505584246.40180-676488900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004527 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 11:33:14.887157) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 11:33:14.889492) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 11:33:14.889826) ========= ========= Total master_lag: 0.98 =========