builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-004 starttime: 1505644148.81 results: success (0) revision: faa897d7948b7e2439573f39c34366c138913663 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-17 03:29:08.808457) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-17 03:29:08.808951) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-17 03:29:08.809235) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-17 03:29:09.240484) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 03:29:09.240880) ========= 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=c6927cf182745ad25b1d38b9000001fe-1505643961.634126-1400065840 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-17 03:29:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2017-09-17 03:29:09 (46.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.172300 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 03:29:09.447415) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 03:29:09.447763) ========= 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=c6927cf182745ad25b1d38b9000001fe-1505643961.634126-1400065840 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018369 ========= master_lag: 0.10 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 03:29:09.567839) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-09-17 03:29:09.573278) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev faa897d7948b7e2439573f39c34366c138913663 --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 faa897d7948b7e2439573f39c34366c138913663 --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=c6927cf182745ad25b1d38b9000001fe-1505643961.634126-1400065840 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-17 03:29:09,829 truncating revision to first 12 chars 2017-09-17 03:29:09,829 Setting DEBUG logging. 2017-09-17 03:29:09,829 attempt 1/10 2017-09-17 03:29:09,829 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/faa897d7948b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-17 03:29:11,245 attempt 1/10 2017-09-17 03:29:11,766 current task status: no status available at this point. state: STARTED 2017-09-17 03:29:11,766 sleeping for 9.00s (attempt 1/10) 2017-09-17 03:29:20,775 attempt 2/10 2017-09-17 03:29:21,096 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-09-17 03:29:21,279 unpacking tar archive at: mozilla-central-faa897d7948b/testing/mozharness/ program finished with exit code 0 elapsedTime=11.817655 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-09-17 03:29:21.420305) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-17 03:29:21.420617) ========= script_repo_revision: faa897d7948b7e2439573f39c34366c138913663 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-17 03:29:21.424153) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-17 03:29:21.424432) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-17 03:29:21.437827) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-09-17 03:29:21.438199) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1505643961.634126-1400065840 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:29:21 INFO - MultiFileLogger online at 20170917 03:29:21 in /builds/slave/test 03:29:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:29:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:29:21 INFO - {'append_to_log': False, 03:29:21 INFO - 'base_work_dir': '/builds/slave/test', 03:29:21 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:29:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:29:21 INFO - 'branch': 'Firefox-Non-PGO', 03:29:21 INFO - 'buildbot_json_path': 'buildprops.json', 03:29:21 INFO - 'code_coverage': False, 03:29:21 INFO - 'config_files': ('talos/linux_config.py',), 03:29:21 INFO - 'default_actions': ('clobber', 03:29:21 INFO - 'read-buildbot-config', 03:29:21 INFO - 'download-and-extract', 03:29:21 INFO - 'populate-webroot', 03:29:21 INFO - 'create-virtualenv', 03:29:21 INFO - 'install', 03:29:21 INFO - 'setup-mitmproxy', 03:29:21 INFO - 'run-tests'), 03:29:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:29:21 INFO - 'disable_ccov_upload': False, 03:29:21 INFO - 'disable_stylo': False, 03:29:21 INFO - 'download_minidump_stackwalk': True, 03:29:21 INFO - 'download_symbols': 'ondemand', 03:29:21 INFO - 'enable_stylo': False, 03:29:21 INFO - 'enable_webrender': False, 03:29:21 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:29:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:29:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:29:21 INFO - 'gecko_profile': False, 03:29:21 INFO - 'gecko_profile_interval': 0, 03:29:21 INFO - 'installer_path': 'installer.exe', 03:29:21 INFO - 'log_level': 'info', 03:29:21 INFO - 'log_name': 'talos', 03:29:21 INFO - 'log_to_console': True, 03:29:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:29:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:29:21 INFO - 'opt_config_files': (), 03:29:21 INFO - 'pip_index': False, 03:29:21 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 03:29:21 INFO - 'system_bits': '32', 03:29:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:29:21 INFO - 'title': 'talos-linux64-ix-004', 03:29:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:29:21 INFO - 'use_talos_json': True, 03:29:21 INFO - 'verify': 'False', 03:29:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:29:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:29:21 INFO - 'work_dir': 'build'} 03:29:21 INFO - [mozharness: 2017-09-17 10:29:21.811554Z] Running clobber step. 03:29:21 INFO - Running pre-action listener: _resource_record_pre_action 03:29:21 INFO - Running main action method: clobber 03:29:21 INFO - rmtree: /builds/slave/test/build 03:29:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:29:23 INFO - Running post-action listener: _resource_record_post_action 03:29:23 INFO - [mozharness: 2017-09-17 10:29:23.322373Z] Finished clobber step (success) 03:29:23 INFO - [mozharness: 2017-09-17 10:29:23.322470Z] Running read-buildbot-config step. 03:29:23 INFO - Running pre-action listener: _resource_record_pre_action 03:29:23 INFO - Running main action method: read_buildbot_config 03:29:23 INFO - Using buildbot properties: 03:29:23 INFO - { 03:29:23 INFO - "project": "", 03:29:23 INFO - "product": "firefox", 03:29:23 INFO - "who": "archaeopteryx@coole-files.de", 03:29:23 INFO - "installer_path": "public/build/target.tar.bz2", 03:29:23 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 03:29:23 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:29:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 03:29:23 INFO - "stage_platform": "linux64", 03:29:23 INFO - "basedir": "/builds/slave/test", 03:29:23 INFO - "buildnumber": 32, 03:29:23 INFO - "platform": "ubuntu64_hw", 03:29:23 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:29:23 INFO - "slavebuilddir": "test", 03:29:23 INFO - "taskId": "I8z4gTo4TpGrOVlFJ-diUw", 03:29:23 INFO - "branch": "mozilla-central", 03:29:23 INFO - "script_repo_revision": "production", 03:29:23 INFO - "revision": "faa897d7948b7e2439573f39c34366c138913663", 03:29:23 INFO - "slavename": "talos-linux64-ix-004", 03:29:23 INFO - "repo_path": "mozilla-central" 03:29:23 INFO - } 03:29:23 INFO - Finding installer, test and symbols from parent task. 03:29:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I8z4gTo4TpGrOVlFJ-diUw'}, attempt #1 03:29:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I8z4gTo4TpGrOVlFJ-diUw'}, attempt #1 03:29:24 INFO - Task dependencies: OSv4zTzPSF2AmqFHfdlHSQ 03:29:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OSv4zTzPSF2AmqFHfdlHSQ'}, attempt #1 03:29:24 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/OSv4zTzPSF2AmqFHfdlHSQ/artifacts/public/build/target.tar.bz2 03:29:24 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/OSv4zTzPSF2AmqFHfdlHSQ/artifacts/public/build/target.test_packages.json 03:29:24 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/OSv4zTzPSF2AmqFHfdlHSQ/artifacts/public/build/target.crashreporter-symbols.zip 03:29:24 INFO - Running post-action listener: _resource_record_post_action 03:29:24 INFO - [mozharness: 2017-09-17 10:29:24.672851Z] Finished read-buildbot-config step (success) 03:29:24 INFO - [mozharness: 2017-09-17 10:29:24.673069Z] Running download-and-extract step. 03:29:24 INFO - Running pre-action listener: _resource_record_pre_action 03:29:24 INFO - Running main action method: download_and_extract 03:29:24 INFO - mkdir: /builds/slave/test/build/tests 03:29:24 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')]} 03:29:24 INFO - trying https://queue.taskcluster.net/v1/task/OSv4zTzPSF2AmqFHfdlHSQ/artifacts/public/build/target.test_packages.json 03:29:24 INFO - Downloading https://queue.taskcluster.net/v1/task/OSv4zTzPSF2AmqFHfdlHSQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:29:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OSv4zTzPSF2AmqFHfdlHSQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:29:25 INFO - Downloaded 989 bytes. 03:29:25 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:29:25 INFO - Using the following test package requirements: 03:29:25 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:29:25 INFO - u'common': [u'target.common.tests.zip'], 03:29:25 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:29:25 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:29:25 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:29:25 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:29:25 INFO - u'mozbase': [u'target.common.tests.zip'], 03:29:25 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:29:25 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:29:25 INFO - u'web-platform': [u'target.common.tests.zip', 03:29:25 INFO - u'target.web-platform.tests.tar.gz'], 03:29:25 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:29:25 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:29:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OSv4zTzPSF2AmqFHfdlHSQ/artifacts/public/build/target.common.tests.zip 03:29:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OSv4zTzPSF2AmqFHfdlHSQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:29:25 INFO - Fetch https://queue.taskcluster.net/v1/task/OSv4zTzPSF2AmqFHfdlHSQ/artifacts/public/build/target.common.tests.zip into memory 03:29:27 INFO - Content-Length response header: 54731186 03:29:27 INFO - Bytes received: 54731186 03:29:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OSv4zTzPSF2AmqFHfdlHSQ/artifacts/public/build/target.talos.tests.zip 03:29:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OSv4zTzPSF2AmqFHfdlHSQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:29:38 INFO - Fetch https://queue.taskcluster.net/v1/task/OSv4zTzPSF2AmqFHfdlHSQ/artifacts/public/build/target.talos.tests.zip into memory 03:29:39 INFO - Content-Length response header: 14508748 03:29:39 INFO - Bytes received: 14508748 03:29:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:40 INFO - trying https://queue.taskcluster.net/v1/task/OSv4zTzPSF2AmqFHfdlHSQ/artifacts/public/build/target.tar.bz2 03:29:40 INFO - Downloading https://queue.taskcluster.net/v1/task/OSv4zTzPSF2AmqFHfdlHSQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:29:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OSv4zTzPSF2AmqFHfdlHSQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:29:43 INFO - Downloaded 61513324 bytes. 03:29:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OSv4zTzPSF2AmqFHfdlHSQ/artifacts/public/build/target.tar.bz2 03:29:43 INFO - mkdir: /builds/slave/test/properties 03:29:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:29:43 INFO - Writing to file /builds/slave/test/properties/build_url 03:29:43 INFO - Contents: 03:29:43 INFO - build_url:https://queue.taskcluster.net/v1/task/OSv4zTzPSF2AmqFHfdlHSQ/artifacts/public/build/target.tar.bz2 03:29:43 INFO - Running post-action listener: _resource_record_post_action 03:29:43 INFO - Running post-action listener: find_tests_for_verification 03:29:43 INFO - Running post-action listener: set_extra_try_arguments 03:29:43 INFO - [mozharness: 2017-09-17 10:29:43.743867Z] Finished download-and-extract step (success) 03:29:43 INFO - [mozharness: 2017-09-17 10:29:43.743986Z] Running populate-webroot step. 03:29:43 INFO - Running pre-action listener: _resource_record_pre_action 03:29:43 INFO - Running main action method: populate_webroot 03:29:43 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:29:43 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:29:43 INFO - 'tests': ['tresize', 03:29:43 INFO - 'tcanvasmark']}, 03:29:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:29:43 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:29:43 INFO - 'tests': ['dromaeo_css', 03:29:43 INFO - 'kraken']}, 03:29:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:29:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:29:43 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:29:43 INFO - 'talos_options': ['--disable-stylo'], 03:29:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:29:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:29:43 INFO - 'tests': ['damp', 'tps']}, 03:29:43 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:29:43 INFO - 'talos_options': ['--disable-stylo'], 03:29:43 INFO - 'tests': ['damp', 'tps']}, 03:29:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:29:43 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:29:43 INFO - 'tests': ['dromaeo_dom']}, 03:29:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:29:43 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:29:43 INFO - 'tests': ['basic_compositor_video', 03:29:43 INFO - 'glvideo']}, 03:29:43 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:29:43 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:29:43 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:29:43 INFO - 'talos_options': ['--disable-stylo'], 03:29:43 INFO - 'tests': ['ts_paint_webext', 03:29:43 INFO - 'tp5o_webext']}, 03:29:43 INFO - 'other-e10s': {'tests': ['a11yr', 03:29:43 INFO - 'ts_paint', 03:29:43 INFO - 'tpaint', 03:29:43 INFO - 'sessionrestore', 03:29:43 INFO - 'sessionrestore_many_windows', 03:29:43 INFO - 'sessionrestore_no_auto_restore', 03:29:43 INFO - 'tabpaint']}, 03:29:43 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:29:43 INFO - 'tests': ['a11yr', 03:29:43 INFO - 'ts_paint', 03:29:43 INFO - 'tpaint', 03:29:43 INFO - 'sessionrestore', 03:29:43 INFO - 'sessionrestore_many_windows', 03:29:43 INFO - 'sessionrestore_no_auto_restore', 03:29:43 INFO - 'tabpaint']}, 03:29:43 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:29:43 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 03:29:43 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:29:43 INFO - 'tests': ['perf_reftest_singletons']}, 03:29:43 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:29:43 INFO - 'tests': ['bloom_basic']}, 03:29:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:29:43 INFO - 'tsvgr_opacity', 03:29:43 INFO - 'tart', 03:29:43 INFO - 'tscrollx', 03:29:43 INFO - 'tsvg_static']}, 03:29:43 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:29:43 INFO - 'tests': ['tsvgx', 03:29:43 INFO - 'tsvgr_opacity', 03:29:43 INFO - 'tart', 03:29:43 INFO - 'tscrollx', 03:29:43 INFO - 'tsvg_static']}, 03:29:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:29:43 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:29:43 INFO - 'talos_options': ['--disable-stylo'], 03:29:43 INFO - 'tests': ['tp5o']}, 03:29:43 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:29:43 INFO - 'talos_options': ['--mitmproxy', 03:29:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:29:43 INFO - '--firstNonBlankPaint'], 03:29:43 INFO - 'tests': ['tp6_google', 03:29:43 INFO - 'tp6_youtube', 03:29:43 INFO - 'tp6_amazon', 03:29:43 INFO - 'tp6_facebook']}, 03:29:43 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:29:43 INFO - 'talos_options': ['--disable-stylo', 03:29:43 INFO - '--mitmproxy', 03:29:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:29:43 INFO - '--firstNonBlankPaint'], 03:29:43 INFO - 'tests': ['tp6_google', 03:29:43 INFO - 'tp6_youtube', 03:29:43 INFO - 'tp6_amazon', 03:29:43 INFO - 'tp6_facebook']}, 03:29:43 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:29:43 INFO - 'talos_options': ['--stylo-threads=1', 03:29:43 INFO - '--mitmproxy', 03:29:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:29:43 INFO - '--firstNonBlankPaint'], 03:29:43 INFO - 'tests': ['tp6_google', 03:29:43 INFO - 'tp6_youtube', 03:29:43 INFO - 'tp6_amazon', 03:29:43 INFO - 'tp6_facebook']}, 03:29:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:29:43 INFO - 'talos_options': ['--xperf_path', 03:29:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:29:43 INFO - 'tests': ['tp5n']}, 03:29:43 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:29:43 INFO - 'talos_options': ['--disable-stylo', 03:29:43 INFO - '--xperf_path', 03:29:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:29:43 INFO - 'tests': ['tp5n']}}} 03:29:43 INFO - Running post-action listener: _resource_record_post_action 03:29:43 INFO - [mozharness: 2017-09-17 10:29:43.764482Z] Finished populate-webroot step (success) 03:29:43 INFO - [mozharness: 2017-09-17 10:29:43.764571Z] Running create-virtualenv step. 03:29:43 INFO - Running pre-action listener: _resource_record_pre_action 03:29:43 INFO - Running main action method: create_virtualenv 03:29:43 INFO - Creating virtualenv /builds/slave/test/build/venv 03:29:43 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:29:43 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:29:43 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:29:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:29:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:29:44 INFO - Installing distribute.............................................................................................................................................................................................done. 03:29:44 INFO - Installing pip...............done. 03:29:44 INFO - Return code: 0 03:29:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:29:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:29:44 INFO - Reading from file tmpfile_stdout 03:29:44 INFO - Output received: 03:29:44 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:29:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:29:44 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')]} 03:29:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:44 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')]} 03:29:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:44 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 0x13f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1763090>, '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 0x1763d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175df90>, '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': 'c6927cf182745ad25b1d38b9000001fe-1505643961.634126-1400065840', '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 03:29:44 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 03:29:44 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 03:29:44 INFO - Using env: {'DISPLAY': ':0', 03:29:44 INFO - 'HOME': '/home/cltbld', 03:29:44 INFO - 'LANG': 'en_US.UTF-8', 03:29:44 INFO - 'LANGUAGE': 'en_US:en', 03:29:44 INFO - 'LOGNAME': 'cltbld', 03:29:44 INFO - 'MAIL': '/var/mail/cltbld', 03:29:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:44 INFO - 'MOZ_NO_REMOTE': '1', 03:29:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:44 INFO - 'NO_EM_RESTART': '1', 03:29:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:44 INFO - 'PWD': '/builds/slave/test', 03:29:44 INFO - 'SHELL': '/bin/bash', 03:29:44 INFO - 'SHLVL': '1', 03:29:44 INFO - 'TERM': 'linux', 03:29:44 INFO - 'TMOUT': '86400', 03:29:44 INFO - 'USER': 'cltbld', 03:29:44 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1505643961.634126-1400065840', 03:29:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:44 INFO - '_': '/tools/buildbot/bin/python'} 03:29:45 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:29:45 INFO - Downloading/unpacking pip>=1.5 03:29:45 INFO - Running setup.py egg_info for package pip 03:29:45 INFO - warning: no files found matching 'pip/cacert.pem' 03:29:45 INFO - warning: no files found matching '*.html' under directory 'docs' 03:29:45 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:29:45 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:29:45 INFO - Installing collected packages: pip 03:29:45 INFO - Found existing installation: pip 1.1 03:29:45 INFO - Uninstalling pip: 03:29:45 INFO - Successfully uninstalled pip 03:29:45 INFO - Running setup.py install for pip 03:29:45 INFO - warning: no files found matching 'pip/cacert.pem' 03:29:45 INFO - warning: no files found matching '*.html' under directory 'docs' 03:29:45 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:29:45 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:29:45 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:29:45 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:29:45 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:29:45 INFO - Successfully installed pip 03:29:45 INFO - Cleaning up... 03:29:45 INFO - Return code: 0 03:29:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:29:45 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')]} 03:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:45 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')]} 03:29:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:45 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 0x13f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1763090>, '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 0x1763d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175df90>, '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': 'c6927cf182745ad25b1d38b9000001fe-1505643961.634126-1400065840', '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 03:29:45 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 03:29:45 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 03:29:45 INFO - Using env: {'DISPLAY': ':0', 03:29:45 INFO - 'HOME': '/home/cltbld', 03:29:45 INFO - 'LANG': 'en_US.UTF-8', 03:29:45 INFO - 'LANGUAGE': 'en_US:en', 03:29:45 INFO - 'LOGNAME': 'cltbld', 03:29:45 INFO - 'MAIL': '/var/mail/cltbld', 03:29:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:45 INFO - 'MOZ_NO_REMOTE': '1', 03:29:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:45 INFO - 'NO_EM_RESTART': '1', 03:29:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:45 INFO - 'PWD': '/builds/slave/test', 03:29:45 INFO - 'SHELL': '/bin/bash', 03:29:45 INFO - 'SHLVL': '1', 03:29:45 INFO - 'TERM': 'linux', 03:29:45 INFO - 'TMOUT': '86400', 03:29:45 INFO - 'USER': 'cltbld', 03:29:45 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1505643961.634126-1400065840', 03:29:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:45 INFO - '_': '/tools/buildbot/bin/python'} 03:29:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:46 INFO - Downloading/unpacking psutil>=3.1.1 03:29:46 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 03:29:46 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 03:29:46 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 03:29:46 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 03:29:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:29:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:29:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:29:47 INFO - Installing collected packages: psutil 03:29:47 INFO - Running setup.py install for psutil 03:29:47 INFO - building 'psutil._psutil_linux' extension 03:29:47 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 03:29:47 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 03:29:47 INFO - building 'psutil._psutil_posix' extension 03:29:47 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 03:29:47 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 03:29:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:29:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:29:47 INFO - Successfully installed psutil 03:29:47 INFO - Cleaning up... 03:29:47 INFO - Return code: 0 03:29:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:29:47 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')]} 03:29:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:47 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')]} 03:29:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:47 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 0x13f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1763090>, '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 0x1763d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175df90>, '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': 'c6927cf182745ad25b1d38b9000001fe-1505643961.634126-1400065840', '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 03:29:47 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 03:29:47 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 03:29:47 INFO - Using env: {'DISPLAY': ':0', 03:29:47 INFO - 'HOME': '/home/cltbld', 03:29:47 INFO - 'LANG': 'en_US.UTF-8', 03:29:47 INFO - 'LANGUAGE': 'en_US:en', 03:29:47 INFO - 'LOGNAME': 'cltbld', 03:29:47 INFO - 'MAIL': '/var/mail/cltbld', 03:29:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:47 INFO - 'MOZ_NO_REMOTE': '1', 03:29:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:47 INFO - 'NO_EM_RESTART': '1', 03:29:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:47 INFO - 'PWD': '/builds/slave/test', 03:29:47 INFO - 'SHELL': '/bin/bash', 03:29:47 INFO - 'SHLVL': '1', 03:29:47 INFO - 'TERM': 'linux', 03:29:47 INFO - 'TMOUT': '86400', 03:29:47 INFO - 'USER': 'cltbld', 03:29:47 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1505643961.634126-1400065840', 03:29:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:47 INFO - '_': '/tools/buildbot/bin/python'} 03:29:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:29:48 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 03:29:48 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 03:29:48 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 03:29:48 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 03:29:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:29:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:29:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:29:49 INFO - Installing collected packages: mozsystemmonitor 03:29:49 INFO - Running setup.py install for mozsystemmonitor 03:29:49 INFO - Successfully installed mozsystemmonitor 03:29:49 INFO - Cleaning up... 03:29:50 INFO - Return code: 0 03:29:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:29:50 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')]} 03:29:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:50 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')]} 03:29:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:50 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 0x13f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1763090>, '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 0x1763d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175df90>, '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': 'c6927cf182745ad25b1d38b9000001fe-1505643961.634126-1400065840', '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 03:29:50 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 03:29:50 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 03:29:50 INFO - Using env: {'DISPLAY': ':0', 03:29:50 INFO - 'HOME': '/home/cltbld', 03:29:50 INFO - 'LANG': 'en_US.UTF-8', 03:29:50 INFO - 'LANGUAGE': 'en_US:en', 03:29:50 INFO - 'LOGNAME': 'cltbld', 03:29:50 INFO - 'MAIL': '/var/mail/cltbld', 03:29:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:50 INFO - 'MOZ_NO_REMOTE': '1', 03:29:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:50 INFO - 'NO_EM_RESTART': '1', 03:29:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:50 INFO - 'PWD': '/builds/slave/test', 03:29:50 INFO - 'SHELL': '/bin/bash', 03:29:50 INFO - 'SHLVL': '1', 03:29:50 INFO - 'TERM': 'linux', 03:29:50 INFO - 'TMOUT': '86400', 03:29:50 INFO - 'USER': 'cltbld', 03:29:50 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1505643961.634126-1400065840', 03:29:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:50 INFO - '_': '/tools/buildbot/bin/python'} 03:29:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:50 INFO - Downloading/unpacking jsonschema==2.5.1 03:29:50 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 03:29:50 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 03:29:50 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 03:29:50 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 03:29:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:29:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:29:51 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 03:29:51 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 03:29:51 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 03:29:51 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 03:29:52 INFO - Downloading functools32-3.2.3-2.tar.gz 03:29:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:29:52 INFO - warning: no files found matching '*.txt' 03:29:52 INFO - no previously-included directories found matching 'build' 03:29:52 INFO - no previously-included directories found matching 'dist' 03:29:52 INFO - no previously-included directories found matching '.git*' 03:29:52 INFO - Installing collected packages: jsonschema, functools32 03:29:52 INFO - Running setup.py install for functools32 03:29:52 INFO - warning: no files found matching '*.txt' 03:29:52 INFO - no previously-included directories found matching 'build' 03:29:52 INFO - no previously-included directories found matching 'dist' 03:29:52 INFO - no previously-included directories found matching '.git*' 03:29:52 INFO - Successfully installed jsonschema functools32 03:29:52 INFO - Cleaning up... 03:29:52 INFO - Return code: 0 03:29:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:29:52 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')]} 03:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:52 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')]} 03:29:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:52 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 0x13f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1763090>, '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 0x1763d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175df90>, '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': 'c6927cf182745ad25b1d38b9000001fe-1505643961.634126-1400065840', '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 03:29:52 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 03:29:52 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 03:29:52 INFO - Using env: {'DISPLAY': ':0', 03:29:52 INFO - 'HOME': '/home/cltbld', 03:29:52 INFO - 'LANG': 'en_US.UTF-8', 03:29:52 INFO - 'LANGUAGE': 'en_US:en', 03:29:52 INFO - 'LOGNAME': 'cltbld', 03:29:52 INFO - 'MAIL': '/var/mail/cltbld', 03:29:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:52 INFO - 'MOZ_NO_REMOTE': '1', 03:29:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:52 INFO - 'NO_EM_RESTART': '1', 03:29:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:52 INFO - 'PWD': '/builds/slave/test', 03:29:52 INFO - 'SHELL': '/bin/bash', 03:29:52 INFO - 'SHLVL': '1', 03:29:52 INFO - 'TERM': 'linux', 03:29:52 INFO - 'TMOUT': '86400', 03:29:52 INFO - 'USER': 'cltbld', 03:29:52 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1505643961.634126-1400065840', 03:29:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:52 INFO - '_': '/tools/buildbot/bin/python'} 03:29:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:29:52 INFO - Cleaning up... 03:29:52 INFO - Return code: 0 03:29:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:29:52 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')]} 03:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:52 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')]} 03:29:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:52 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 0x13f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1763090>, '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 0x1763d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175df90>, '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': 'c6927cf182745ad25b1d38b9000001fe-1505643961.634126-1400065840', '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 03:29:52 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 03:29:52 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 03:29:52 INFO - Using env: {'DISPLAY': ':0', 03:29:52 INFO - 'HOME': '/home/cltbld', 03:29:52 INFO - 'LANG': 'en_US.UTF-8', 03:29:52 INFO - 'LANGUAGE': 'en_US:en', 03:29:52 INFO - 'LOGNAME': 'cltbld', 03:29:52 INFO - 'MAIL': '/var/mail/cltbld', 03:29:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:52 INFO - 'MOZ_NO_REMOTE': '1', 03:29:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:52 INFO - 'NO_EM_RESTART': '1', 03:29:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:52 INFO - 'PWD': '/builds/slave/test', 03:29:52 INFO - 'SHELL': '/bin/bash', 03:29:52 INFO - 'SHLVL': '1', 03:29:52 INFO - 'TERM': 'linux', 03:29:52 INFO - 'TMOUT': '86400', 03:29:52 INFO - 'USER': 'cltbld', 03:29:52 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1505643961.634126-1400065840', 03:29:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:52 INFO - '_': '/tools/buildbot/bin/python'} 03:29:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:52 INFO - Downloading/unpacking blobuploader==1.2.4 03:29:52 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 03:29:52 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 03:29:52 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 03:29:52 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 03:29:53 INFO - Downloading blobuploader-1.2.4.tar.gz 03:29:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:29:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:29:53 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 03:29:53 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 03:29:53 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 03:29:53 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 03:29:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:29:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:29:54 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 03:29:54 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 03:29:54 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 03:29:54 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 03:29:54 INFO - Downloading docopt-0.6.1.tar.gz 03:29:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:29:54 INFO - Installing collected packages: blobuploader, requests, docopt 03:29:54 INFO - Running setup.py install for blobuploader 03:29:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:29:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:29:54 INFO - Running setup.py install for requests 03:29:54 INFO - Running setup.py install for docopt 03:29:55 INFO - Successfully installed blobuploader requests docopt 03:29:55 INFO - Cleaning up... 03:29:55 INFO - Return code: 0 03:29:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:29: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')]} 03:29:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29: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')]} 03:29:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:55 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 0x13f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1763090>, '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 0x1763d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175df90>, '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': 'c6927cf182745ad25b1d38b9000001fe-1505643961.634126-1400065840', '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 03:29:55 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 03:29:55 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 03:29:55 INFO - Using env: {'DISPLAY': ':0', 03:29:55 INFO - 'HOME': '/home/cltbld', 03:29:55 INFO - 'LANG': 'en_US.UTF-8', 03:29:55 INFO - 'LANGUAGE': 'en_US:en', 03:29:55 INFO - 'LOGNAME': 'cltbld', 03:29:55 INFO - 'MAIL': '/var/mail/cltbld', 03:29:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:55 INFO - 'MOZ_NO_REMOTE': '1', 03:29:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:55 INFO - 'NO_EM_RESTART': '1', 03:29:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:55 INFO - 'PWD': '/builds/slave/test', 03:29:55 INFO - 'SHELL': '/bin/bash', 03:29:55 INFO - 'SHLVL': '1', 03:29:55 INFO - 'TERM': 'linux', 03:29:55 INFO - 'TMOUT': '86400', 03:29:55 INFO - 'USER': 'cltbld', 03:29:55 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1505643961.634126-1400065840', 03:29:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:55 INFO - '_': '/tools/buildbot/bin/python'} 03:29:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:29:55 INFO - Running setup.py (path:/tmp/pip-sihujd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:29:55 INFO - Running setup.py (path:/tmp/pip-jPlblk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:29:55 INFO - Running setup.py (path:/tmp/pip-RFFz7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:29:55 INFO - Running setup.py (path:/tmp/pip-oRef1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:29:55 INFO - Running setup.py (path:/tmp/pip-076WJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:29:55 INFO - Running setup.py (path:/tmp/pip-3JYZQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:29:55 INFO - Running setup.py (path:/tmp/pip-b4fw5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:29:55 INFO - Running setup.py (path:/tmp/pip-tH4Krq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:29:55 INFO - Running setup.py (path:/tmp/pip-cSOqAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:29:55 INFO - Running setup.py (path:/tmp/pip-qXncvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:29:55 INFO - Running setup.py (path:/tmp/pip-pKPop3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:29:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:29:56 INFO - Running setup.py (path:/tmp/pip-JdI6q7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:29:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:29:56 INFO - Running setup.py (path:/tmp/pip-dcUw_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:29:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:29:56 INFO - Running setup.py (path:/tmp/pip-kn645W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:29:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:56 INFO - Running setup.py (path:/tmp/pip-wUS90L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:29:56 INFO - Running setup.py (path:/tmp/pip-US4ZIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:29:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:29:56 INFO - Running setup.py (path:/tmp/pip-2JMGsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:29:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:29:56 INFO - Running setup.py install for manifestparser 03:29:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:29:56 INFO - Running setup.py install for mozcrash 03:29:56 INFO - Running setup.py install for mozdebug 03:29:56 INFO - Running setup.py install for mozdevice 03:29:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:29:56 INFO - Running setup.py install for mozfile 03:29:56 INFO - Running setup.py install for mozhttpd 03:29:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:29:57 INFO - Running setup.py install for mozinfo 03:29:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:29:57 INFO - Running setup.py install for mozInstall 03:29:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:29:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:29:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:29:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:29:57 INFO - Running setup.py install for mozleak 03:29:57 INFO - Running setup.py install for mozlog 03:29:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:29:57 INFO - Running setup.py install for moznetwork 03:29:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:29:57 INFO - Running setup.py install for mozprocess 03:29:57 INFO - Running setup.py install for mozprofile 03:29:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:29:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:29:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:29:57 INFO - Running setup.py install for mozrunner 03:29:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:29:57 INFO - Running setup.py install for mozscreenshot 03:29:57 INFO - Running setup.py install for moztest 03:29:58 INFO - Running setup.py install for mozversion 03:29:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:29:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:29:58 INFO - Cleaning up... 03:29:58 INFO - Return code: 0 03:29:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:29: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')]} 03:29:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29: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')]} 03:29:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:58 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 0x13f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1763090>, '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 0x1763d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175df90>, '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': 'c6927cf182745ad25b1d38b9000001fe-1505643961.634126-1400065840', '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 03:29:58 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 03:29:58 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 03:29:58 INFO - Using env: {'DISPLAY': ':0', 03:29:58 INFO - 'HOME': '/home/cltbld', 03:29:58 INFO - 'LANG': 'en_US.UTF-8', 03:29:58 INFO - 'LANGUAGE': 'en_US:en', 03:29:58 INFO - 'LOGNAME': 'cltbld', 03:29:58 INFO - 'MAIL': '/var/mail/cltbld', 03:29:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:58 INFO - 'MOZ_NO_REMOTE': '1', 03:29:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:58 INFO - 'NO_EM_RESTART': '1', 03:29:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:58 INFO - 'PWD': '/builds/slave/test', 03:29:58 INFO - 'SHELL': '/bin/bash', 03:29:58 INFO - 'SHLVL': '1', 03:29:58 INFO - 'TERM': 'linux', 03:29:58 INFO - 'TMOUT': '86400', 03:29:58 INFO - 'USER': 'cltbld', 03:29:58 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1505643961.634126-1400065840', 03:29:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:58 INFO - '_': '/tools/buildbot/bin/python'} 03:29:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:29:58 INFO - Running setup.py (path:/tmp/pip-PhXHIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:29:58 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)) 03:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:29:58 INFO - Running setup.py (path:/tmp/pip-8AsMru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:29:58 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)) 03:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:29:58 INFO - Running setup.py (path:/tmp/pip-718wrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:29:58 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)) 03:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:29:58 INFO - Running setup.py (path:/tmp/pip-KU59ib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:29:58 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)) 03:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:29:58 INFO - Running setup.py (path:/tmp/pip-u_T0al-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:29:58 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)) 03:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:29:58 INFO - Running setup.py (path:/tmp/pip-83Yusy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:29:58 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)) 03:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:29:58 INFO - Running setup.py (path:/tmp/pip-gVwG9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:29:58 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)) 03:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:29:58 INFO - Running setup.py (path:/tmp/pip-mRYdQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:29:59 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)) 03:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:29:59 INFO - Running setup.py (path:/tmp/pip-TaXZ_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:29:59 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)) 03:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:29:59 INFO - Running setup.py (path:/tmp/pip-fosRgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:29:59 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)) 03:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:29:59 INFO - Running setup.py (path:/tmp/pip-BYqbIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:29:59 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)) 03:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:29:59 INFO - Running setup.py (path:/tmp/pip-uXmkyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:29:59 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)) 03:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:29:59 INFO - Running setup.py (path:/tmp/pip-RdczWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:29:59 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)) 03:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:29:59 INFO - Running setup.py (path:/tmp/pip-E23h05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:29:59 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)) 03:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:59 INFO - Running setup.py (path:/tmp/pip-1Gu4vh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:59 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)) 03:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:29:59 INFO - Running setup.py (path:/tmp/pip-4VCqnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:29:59 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)) 03:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:29:59 INFO - Running setup.py (path:/tmp/pip-TZn2vO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:29:59 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)) 03:29:59 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)) 03:29:59 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)) 03:29:59 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)) 03:29:59 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)) 03:29:59 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)) 03:29:59 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)) 03:29:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:00 INFO - Downloading blessings-1.6.tar.gz 03:30:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:30:00 INFO - Installing collected packages: blessings 03:30:00 INFO - Running setup.py install for blessings 03:30:00 INFO - Successfully installed blessings 03:30:00 INFO - Cleaning up... 03:30:00 INFO - Return code: 0 03:30:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:30:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:30:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:30:01 INFO - Reading from file tmpfile_stdout 03:30:01 INFO - Current package versions: 03:30:01 INFO - argparse == 1.2.1 03:30:01 INFO - blessings == 1.6 03:30:01 INFO - blobuploader == 1.2.4 03:30:01 INFO - docopt == 0.6.1 03:30:01 INFO - functools32 == 3.2.3-2 03:30:01 INFO - jsonschema == 2.5.1 03:30:01 INFO - manifestparser == 1.1 03:30:01 INFO - mozInstall == 1.13 03:30:01 INFO - mozcrash == 1.0 03:30:01 INFO - mozdebug == 0.1 03:30:01 INFO - mozdevice == 0.51 03:30:01 INFO - mozfile == 1.2 03:30:01 INFO - mozhttpd == 0.7 03:30:01 INFO - mozinfo == 0.10 03:30:01 INFO - mozleak == 0.1 03:30:01 INFO - mozlog == 3.5 03:30:01 INFO - moznetwork == 0.27 03:30:01 INFO - mozprocess == 0.25 03:30:01 INFO - mozprofile == 0.28 03:30:01 INFO - mozrunner == 6.13 03:30:01 INFO - mozscreenshot == 0.1 03:30:01 INFO - mozsystemmonitor == 0.3 03:30:01 INFO - moztest == 0.8 03:30:01 INFO - mozversion == 1.4 03:30:01 INFO - psutil == 3.1.1 03:30:01 INFO - requests == 1.2.3 03:30:01 INFO - wsgiref == 0.1.2 03:30:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:30:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:01 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 0x13f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1763090>, '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 0x1763d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175df90>, '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': 'c6927cf182745ad25b1d38b9000001fe-1505643961.634126-1400065840', '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 03:30:01 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 03:30:01 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 03:30:01 INFO - Using env: {'DISPLAY': ':0', 03:30:01 INFO - 'HOME': '/home/cltbld', 03:30:01 INFO - 'LANG': 'en_US.UTF-8', 03:30:01 INFO - 'LANGUAGE': 'en_US:en', 03:30:01 INFO - 'LOGNAME': 'cltbld', 03:30:01 INFO - 'MAIL': '/var/mail/cltbld', 03:30:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:01 INFO - 'MOZ_NO_REMOTE': '1', 03:30:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:01 INFO - 'NO_EM_RESTART': '1', 03:30:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:01 INFO - 'PWD': '/builds/slave/test', 03:30:01 INFO - 'SHELL': '/bin/bash', 03:30:01 INFO - 'SHLVL': '1', 03:30:01 INFO - 'TERM': 'linux', 03:30:01 INFO - 'TMOUT': '86400', 03:30:01 INFO - 'USER': 'cltbld', 03:30:01 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1505643961.634126-1400065840', 03:30:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:01 INFO - '_': '/tools/buildbot/bin/python'} 03:30:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:01 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)) 03:30:01 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)) 03:30:01 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)) 03:30:01 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)) 03:30:01 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)) 03:30:01 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)) 03:30:01 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)) 03:30:01 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)) 03:30:01 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)) 03:30:01 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:30:02 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)) 03:30:02 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)) 03:30:02 INFO - Installing collected packages: simplejson 03:30:02 INFO - Running setup.py install for simplejson 03:30:02 INFO - building 'simplejson._speedups' extension 03:30:02 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 03:30:03 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 03:30:03 INFO - Successfully installed simplejson 03:30:03 INFO - Cleaning up... 03:30:03 INFO - Return code: 0 03:30:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:30:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1763090>, '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 0x1763d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175df90>, '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': 'c6927cf182745ad25b1d38b9000001fe-1505643961.634126-1400065840', '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 03:30:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:30:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:30:03 INFO - Using env: {'DISPLAY': ':0', 03:30:03 INFO - 'HOME': '/home/cltbld', 03:30:03 INFO - 'LANG': 'en_US.UTF-8', 03:30:03 INFO - 'LANGUAGE': 'en_US:en', 03:30:03 INFO - 'LOGNAME': 'cltbld', 03:30:03 INFO - 'MAIL': '/var/mail/cltbld', 03:30:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:03 INFO - 'MOZ_NO_REMOTE': '1', 03:30:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:03 INFO - 'NO_EM_RESTART': '1', 03:30:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:03 INFO - 'PWD': '/builds/slave/test', 03:30:03 INFO - 'SHELL': '/bin/bash', 03:30:03 INFO - 'SHLVL': '1', 03:30:03 INFO - 'TERM': 'linux', 03:30:03 INFO - 'TMOUT': '86400', 03:30:03 INFO - 'USER': 'cltbld', 03:30:03 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1505643961.634126-1400065840', 03:30:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:03 INFO - '_': '/tools/buildbot/bin/python'} 03:30:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:30:03 INFO - Cleaning up... 03:30:03 INFO - Return code: 0 03:30:03 INFO - Running post-action listener: _resource_record_post_action 03:30:03 INFO - Running post-action listener: _start_resource_monitoring 03:30:03 INFO - Starting resource monitoring. 03:30:03 INFO - [mozharness: 2017-09-17 10:30:03.906959Z] Finished create-virtualenv step (success) 03:30:03 INFO - [mozharness: 2017-09-17 10:30:03.907472Z] Running install step. 03:30:03 INFO - Running pre-action listener: _resource_record_pre_action 03:30:03 INFO - Running main action method: install 03:30:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:30:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:30:04 INFO - Reading from file tmpfile_stdout 03:30:04 INFO - Detecting whether we're running mozinstall >=1.0... 03:30:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:30:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:30:04 INFO - Reading from file tmpfile_stdout 03:30:04 INFO - Output received: 03:30:04 INFO - Usage: mozinstall [options] installer 03:30:04 INFO - Options: 03:30:04 INFO - -h, --help show this help message and exit 03:30:04 INFO - -d DEST, --destination=DEST 03:30:04 INFO - Directory to install application into. [default: 03:30:04 INFO - "/builds/slave/test"] 03:30:04 INFO - --app=APP Application being installed. [default: firefox] 03:30:04 INFO - mkdir: /builds/slave/test/build/application 03:30:04 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'] 03:30:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:30:21 INFO - Reading from file tmpfile_stdout 03:30:21 INFO - Output received: 03:30:21 INFO - /builds/slave/test/build/application/firefox/firefox 03:30:22 INFO - Running post-action listener: _resource_record_post_action 03:30:22 INFO - [mozharness: 2017-09-17 10:30:22.000424Z] Finished install step (success) 03:30:22 INFO - [mozharness: 2017-09-17 10:30:22.000674Z] Running setup-mitmproxy step. 03:30:22 INFO - Running pre-action listener: _resource_record_pre_action 03:30:22 INFO - Running main action method: setup_mitmproxy 03:30:22 INFO - Skipping: mitmproxy is not required 03:30:22 INFO - Running post-action listener: _resource_record_post_action 03:30:22 INFO - [mozharness: 2017-09-17 10:30:22.001803Z] Finished setup-mitmproxy step (success) 03:30:22 INFO - [mozharness: 2017-09-17 10:30:22.002023Z] Running run-tests step. 03:30:22 INFO - Running pre-action listener: _resource_record_pre_action 03:30:22 INFO - Running pre-action listener: _set_gcov_prefix 03:30:22 INFO - Running main action method: run_tests 03:30:22 WARNING - Try message not found. 03:30:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:30:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:30:22 INFO - Python 2.7.3 03:30:22 INFO - Return code: 0 03:30:22 INFO - grabbing minidump binary from tooltool 03:30:22 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')]} 03:30:22 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 0x1763090>, '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 0x1763d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175df90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:30:22 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 03:30:22 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 03:30:22 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 03:30:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:30:22 INFO - Return code: 0 03:30:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:30:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:30:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:30:22 INFO - ENV: RUST_BACKTRACE is now full 03:30:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:30:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:30:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OSv4zTzPSF2AmqFHfdlHSQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 03:30:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OSv4zTzPSF2AmqFHfdlHSQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-004 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 03:30:22 INFO - Using env: {'DISPLAY': ':0', 03:30:22 INFO - 'HOME': '/home/cltbld', 03:30:22 INFO - 'LANG': 'en_US.UTF-8', 03:30:22 INFO - 'LANGUAGE': 'en_US:en', 03:30:22 INFO - 'LOGNAME': 'cltbld', 03:30:22 INFO - 'MAIL': '/var/mail/cltbld', 03:30:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:30:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:30:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:22 INFO - 'MOZ_NO_REMOTE': '1', 03:30:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:30:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:22 INFO - 'NO_EM_RESTART': '1', 03:30:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:22 INFO - 'PWD': '/builds/slave/test', 03:30:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:30:22 INFO - 'RUST_BACKTRACE': 'full', 03:30:22 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:30:22 INFO - 'SHELL': '/bin/bash', 03:30:22 INFO - 'SHLVL': '1', 03:30:22 INFO - 'TERM': 'linux', 03:30:22 INFO - 'TMOUT': '86400', 03:30:22 INFO - 'USER': 'cltbld', 03:30:22 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1505643961.634126-1400065840', 03:30:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:22 INFO - '_': '/tools/buildbot/bin/python'} 03:30:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OSv4zTzPSF2AmqFHfdlHSQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 03:30:22 INFO - mozversion application_buildid: 20170917094019 03:30:22 INFO - mozversion application_changeset: faa897d7948b7e2439573f39c34366c138913663 03:30:22 INFO - mozversion application_display_name: Nightly 03:30:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:30:22 INFO - mozversion application_name: Firefox 03:30:22 INFO - mozversion application_remotingname: firefox 03:30:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:30:22 INFO - mozversion application_vendor: Mozilla 03:30:22 INFO - mozversion application_version: 57.0a1 03:30:22 INFO - mozversion platform_buildid: 20170917094019 03:30:22 INFO - mozversion platform_changeset: faa897d7948b7e2439573f39c34366c138913663 03:30:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:30:22 INFO - mozversion platform_version: 57.0a1 03:30:22 INFO - using testdate: 1505644222 03:30:22 INFO - actual date: 1505644222 03:30:22 INFO - starting webserver on 'localhost:47614' 03:30:22 INFO - SUITE-START | Running 2 tests 03:30:22 INFO - TEST-START | dromaeo_css 03:30:22 INFO - Initialising browser for dromaeo_css test... 03:30:22 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47614/getInfo.html -profile /tmp/tmpse5bUi/profile 03:30:22 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/firefox/firefox http://localhost:47614/getInfo.html) 03:30:28 INFO - TEST-INFO | 1657: exit 0 03:30:28 INFO - Browser initialized. 03:30:28 INFO - Running cycle 1/1 for dromaeo_css test... 03:30:28 INFO - Using env: {'DISPLAY': ':0', 03:30:28 INFO - 'HOME': '/home/cltbld', 03:30:28 INFO - 'JSGC_DISABLE_POISONING': '1', 03:30:28 INFO - 'LANG': 'en_US.UTF-8', 03:30:28 INFO - 'LANGUAGE': 'en_US:en', 03:30:28 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:30:28 INFO - 'LOGNAME': 'cltbld', 03:30:28 INFO - 'MAIL': '/var/mail/cltbld', 03:30:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:30:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:30:28 INFO - 'MOZ_CRASHREPORTER': '1', 03:30:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:28 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:30:28 INFO - 'MOZ_NO_REMOTE': '1', 03:30:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:30:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:28 INFO - 'NO_EM_RESTART': '1', 03:30:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:28 INFO - 'PWD': '/builds/slave/test', 03:30:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:30:28 INFO - 'RUST_BACKTRACE': 'full', 03:30:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:30:28 INFO - 'SHELL': '/bin/bash', 03:30:28 INFO - 'SHLVL': '1', 03:30:28 INFO - 'STYLO_FORCE_DISABLED': '1', 03:30:28 INFO - 'TERM': 'linux', 03:30:28 INFO - 'TMOUT': '86400', 03:30:28 INFO - 'USER': 'cltbld', 03:30:28 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1505643961.634126-1400065840', 03:30:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:28 INFO - '_': '/tools/buildbot/bin/python'} 03:30:28 INFO - TEST-INFO | started process 1885 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpse5bUi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:30:29 INFO - PID 1885 | 03:30:29 INFO - PID 1885 | (/builds/slave/test/build/application/firefox/firefox:1936): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:30:29 INFO - PID 1885 | 03:30:39 INFO - PID 1885 | RSS: Main: 156717056 03:30:39 INFO - PID 1885 | 03:33:36 INFO - PID 1885 | Cycle 1(1): loaded http://localhost:47614/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47614/tests/dromaeo/cssquery-ext.html) 03:33:36 INFO - PID 1885 | RSS: Main: 156213248 03:33:36 INFO - PID 1885 | 03:36:38 INFO - PID 1885 | Cycle 1(1): loaded http://localhost:47614/tests/dromaeo/cssquery-ext.html (next: http://localhost:47614/tests/dromaeo/cssquery-jquery.html) 03:36:39 INFO - PID 1885 | RSS: Main: 156037120 03:36:39 INFO - PID 1885 | 03:39:41 INFO - PID 1885 | Cycle 1(1): loaded http://localhost:47614/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47614/tests/dromaeo/cssquery-mootools.html) 03:39:41 INFO - PID 1885 | RSS: Main: 158162944 03:39:41 INFO - PID 1885 | 03:42:43 INFO - PID 1885 | Cycle 1(1): loaded http://localhost:47614/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47614/tests/dromaeo/cssquery-prototype.html) 03:42:44 INFO - PID 1885 | RSS: Main: 156741632 03:42:44 INFO - PID 1885 | 03:45:47 INFO - PID 1885 | Cycle 1(1): loaded http://localhost:47614/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47614/tests/dromaeo/cssquery-yui.html) 03:45:47 INFO - PID 1885 | RSS: Main: 157724672 03:45:47 INFO - PID 1885 | 03:48:49 INFO - PID 1885 | Cycle 1(1): loaded http://localhost:47614/tests/dromaeo/cssquery-yui.html (next: http://localhost:47614/tests/dromaeo/cssquery-dojo.html) 03:48:49 INFO - PID 1885 | RSS: Main: 160124928 03:48:49 INFO - PID 1885 | 03:48:49 INFO - PID 1885 | __start_tp_report 03:48:49 INFO - PID 1885 | _x_x_mozilla_page_load 03:48:49 INFO - PID 1885 | _x_x_mozilla_page_load_details 03:48:49 INFO - PID 1885 | |i|pagename|runs| 03:48:49 INFO - PID 1885 | |0;dojo.html;3161.067485091899;3162.6995435433632;3178.6821317868207;3187.091678871522;3190.0589326148784;6200.720967556459;6280.214973128359;6285.905711414327;6341.968290158555;6408.871822563552;6210.565260431772;6224.626522408658;6234.033724772657;6254.030625253082;6265.060240963858;5768.538516918637;5814.767409303644;5839.328477225131;5888.676122813244;5893.705314734268;5824.301083869942;5872.354041055481;5884.4703976642095;5902.2622172228475;5949.702514874239;1.9786251946825855;5702.714864256791;5721.170430287606;5841.0362290222065;5938.910916336258;5774.335951365605;5776.046952252873;5844.298684157886;5850.561207909382;5859.648421094706;5730.025895597759;5752.050911599581;5809.564282678816;5816.1275808628625;5816.738246778905;6238.688065596747;6275.8744825103695;6292.62244265341;6332.651704156269;6339.397757213057;6702.396784289437;6714.429273511757;6794.946783248604;6798.456123510107;6814.761483348108;6597.340265973412;6800.081988931481;6816.113905192294;6896;6904.171499420051;6204.6587437690905;6239.65681887496;6313.968430157865;6317.93682063178;6327.019312006601;6996.825079373006;7018.859622807618;7053.435725141976;7055.89416158758;7071.8939215911805;6645.867082658319;6652.168478940132;6718.126643536309;6726.058351830748;6731.057651928734;6676.399124078759;6753.898691519631;6760.256371799098;6775.22084960226;6848.623325717133;6714.899276510856;6717.496187785936;6725.932740672629;6732.932670673231;6734.023566582818;6743.460523158135;6777.390034896883;6818;6839.726410943506;6843.0419741236265;5287.365516138088;5292.153255479105;5349.277847490617;5359.973200134053;5361.544268737123;4481.775911204427;4579.587837094611;4596.701214421052;4622;4648.3259927310355;5708;5768.653880767168;5773.769049237983;5774.04728219839;5814.098814683731;6670.0661907333015;6811.25076241613;6841.62371069586;6849.486288528281;6856.485763567653;5833.0375488044;5847.181394604759;5907.113932910098;5908.527317814651;5916.201312822714;5649.858753531194;5667.829965101054;5684.8294551163535;5726.169705392778;5836;6411.67941602918;6566.638834864033;6578.144841170617;6582.308857569887;6644.700988455531;6750.392464678006;6806.149231346082;6830.043793868862;6860.965695171492;6862.965685171642;6594.802155935329;6618.503612229006;6678.23200331968;6680.3987641112535;6685.53201275906;6619.768308109193;6661.733530658719;6709.194896612437;6724.159480064992;6725.226598940989;6540.051692504465;6674.966625166843;6706.128203333536;6782.8643427132165;6810.489213309121;6560.639164845979;6573.276939536743;6622.569532980341;6641.136652235178;6647.867042659023;6559.8032059038305;6576.2766095728475;6622.1722284714415;6638.933610663831;6650.700718467778;6466.644334561456;6469.159009328757;6556.082148499118;6563.310852360433;6566.474682025522;6415.358464153547;6507.772227971998;6570.868582628225;6586.604803711793;6680.4989625779235;6182.567220294536;6358.205224346957;6404.263509696445;6454.741810327534;6467.450266727381 03:48:49 INFO - PID 1885 | |1;ext.html;854.5684429363171;864.7708357285317;879.2306731609839;884.0364003236471;892.5894088719185;41351.58648413515;42409.7879510602;42432.78783606078;42467;42535.57464425359;38115.04712382192;38608.420873686846;38617;38627.22745545088;38638.22723545528;7007.054047703558;7153.89269160963;7156.391706704936;7168.749093781718;7175.89236161458;6944.826379340507;7015.579065256075;7017.789466316019;7023.859522809541;7039.472039597025;7716.151223365426;7858.214178582153;7871.645775940096;7880.881786773203;7886.408519361043;7759.6120193990355;7774.416918731061;7782.688692452295;7826.882596761025;7844.254795794391;7576.696932122709;7762.844743105106;7806.531608103532;7840.921590784076;7843.764687059397;39147.21705565901;39229.21541569153;39303.41044884329;39510;39563.8021809892;3526.7883926964464;3559.519464872235;3590.3716849551224;3595.352836489431;3596.2627661329366;31250.90621828248;31304.686953130633;31532.527012094837;31636.525452118236;31725.04824855258;5200.323957885488;5271.472852714736;5321.095413779667;5322.281491998569;5325.334333208349;183946;185180.99999999866;190611;192101;192359;43420.565794342285;48816.755916220194;49917.500824991286;49931.25103123456;50055;51762.48237517652;51813.222801658005;51828.48171518312;51836.48163518317;51883;15313.310901009481;15420.922895385676;15448.227588620524;15467.613309667124;15482.84517154814;12391.93804030974;12452.128351015343;12455.688607784878;12472.126951113516;12474.75050498985;13967.37146828395;14103.365348559135;14384.424623014962;14498.11524501808;14654.780178297335;5787.71061446926;5808.82573522795;5916.5858389913155;5933.2880054393745;5973.850653733692;1020.806046851096;1027.5992362978295;1028.753099256173;1045.482486169351;1047.759015426441;22602.434939126655;23037.769622303564;23068.077276909073;23102.884485577466;23460.413489662897;1123.9438028098562;1124.8515335708757;1132.335466863709;1161.1697636190165;1161.924474909128;11867.762644747057;12185.69535761613;12202.450889709808;12213.206141600767;12218.572349967708;222241;223051;223259;223298;223341;52823.73588132035;53005.46994530082;53112.73443632757;53118.73440632772;53258;1440.719059783332;1464.5899148238511;1486.3831509923477;1503.3084781000643;1508.2157278215266;22581.548369032855;22600.208992685177;22692.432689182904;22695;22780.544389111794;38011.61988380191;38049.80975095107;38066.238675226894;38073;38142.42786358263;187024;188039;188273;189036;189537;30787.692123079378;31343;34535.136621584665;34902.30195396129;35341.29317413689;42465.5753442474;42487.787561061996;42549.78725106355;42836.14327713491;43063;32452.35095298128;32483.350332992733;32497.837510812296;32821.671783282814;33173.17067073246;31229.531557027116;31511.21221969469;31559.21101972377;31808.840955795073;32007;35024.474632881036;35105.473417899266;35281;35315;35413.46879796857;30923.69076309208;31181.84409078031;31234.21914452157;31408.842955785076;31462.370752585277;22379.552408951404;22616.886915565316;22802.42993925099;23162.1893233736;23451.648225276294 03:48:49 INFO - PID 1885 | |2;jquery.html;545.7980547197537;549.4148731600844;551.2640624765935;587.5064945445826;592.1325258496302;22164.667529987044;22505.212317568887;22714;22997.195098171567;23058.65412018821;23745.40636484089;23951.880240598817;24112.276631701076;24159.63760543593;25050;6476.773312934049;6686.498512611549;6688.0971068905565;6714.731410743564;6722.630255335955;6294.055891616248;6558.081868538408;6641.568298060611;6660.367265109807;6682.365175308338;6514.827331080403;6532.836679083013;6533.542652014361;6534.117894084286;6537.5750576212395;6521;6523.673816309166;6524.93475065248;6532.281449040578;6538.836529086763;6059.697015149225;6767.390934815841;7075.080239568823;7090.822729431754;7105.573665580082;31475;32325.35349293001;32429.51355729666;32445.83777081123;32453.188670283194;2060.2789023841538;2086.7495900491886;2089.0912453082806;2089.7387826521685;2092.5501017281204;20615.5876882463;20895.68656470154;21245.25641602552;21300.147994080216;21504.354869353945;2561.8462892226526;2582.535143674138;2608.282722251377;2642.3526236072285;2653.2173008962404;118354.40822795917;125478;131021;135103;136999.999999999;20938.37184884456;21112.78887211139;21818.563628727337;22191.115155029744;22208.77791222067;41840.790796046436;41940.37089443661;41953.580464194965;42163.367549486786;42348.57651423508;11489.253198542068;11894.167408281337;11977;12033.759324813629;12068.517259309705;9867.802643947225;9893;9972.002799720116;9978.600855965826;9995.300328976902;11419.48612312448;11518.481668324945;11570.710732231762;11675.532978680758;12014.939925300492;4077.89805254871;4423.380726698265;4523.796429160696;4545.36364908913;4570.291604801261;951.8477043672979;965.0542468381026;972.2999440402899;977.3354119199013;986.9851952220722;19193.712094318595;19329.47722799954;19538.12078456473;19793.802061979484;20097.29659461941;1017.8218811707922;1022.0801278848946;1022.5909636145601;1023.4729114506035;1025.3130402630106;10744.516496757664;10820.94589527063;10838.42842787807;10915.890841091647;11134.554617815358;460166;469291;470022;480562;482694;108265.45867270613;110290.44854775675;110342;110393;111964;1026.2610920137488;1072.126217133034;1132.92069555132;1145.7823013627385;1191.940402979865;20496.18015279372;20787.272445464336;20795.58408831845;20844.895775521025;20866.37400877976;54306.18540721813;54505;54651;55353.44646553644;57528;68920.6553967247;69927.65036174786;70273.64863175651;70889;71106.64446677733;18947.147378367732;19122;19776.813391196574;20100.497487562927;20292.89853550782;22952.4261893454;23040.539189215786;23068.769312306664;23321.533569328178;23322.067117315117;18159.182836772114;18168.182431790337;18394.595510208404;18424.35514756977;18561.721574176667;15294.00588961714;15558.766618500506;16695.49913502597;17364.56588585245;17443.040632765318;16843.494695159166;17041.318347266468;17152.828471715624;18152.27390904349;18790.15444304982;18567.16447759881;18574.907125464288;18582.25670973146;18618.348357807954;18635.44093677192;16815.41146059882;16901.661966760843;16951.745723814398;17068.402605908734;18037.098145092954 03:48:49 INFO - PID 1885 | |3;mootools.html;1345.6030471011052;1403.7473254814136;1405.423776251737;1407.0432106167802;1407.486267512358;15090.094594324348;15725.056496610212;15729.292181851815;15753.606159845995;15757.369705211791;15239.923800380982;15317;15351.385944562233;15390.15354155521;15427.614309642264;2638.7229340919216;2672.2384120525653;2707.553253713135;2735.726427357268;2736.5621500559914;2643.4977354302623;2679.6114563388296;2693.4343787804582;2693.9326516837136;2702.3784529558216;2637.997560926845;2647.272000199941;2741.643586333774;2743.8353698778037;2748.9862550687317;2640.2079376187257;2673.70589235184;2683.8523881186525;2685.925629748097;2687.583424569195;2675.745804148622;2775.680796708364;2783.9443211135663;2786.5541513357966;2786.6238057862133;15300;15394.615134621612;15421.845781542266;15428.845711542854;15439.459618913397;8077.394195435366;8431.95784021076;8434.831303373898;8438.704645337446;8446.324294056461;5560.277163968658;5563.582731295169;5569.777208911639;5742.7415766290615;5751.597388182829;1841.484384372378;1864.3008871673123;1864.4499872537633;1891.7919028906808;1902.9429117126508;26219.344516387053;26642.86678566595;26798;26963.325916852235;27098.729012709817;6948.235694073648;6958.408535274457;7187.065681461377;7196.280371962762;7265.745698900513;17361.47915562535;17373.913130434266;17383.91308043452;17387.21757520889;17396.82603173952;7949.443538952333;8088.272055515032;8157.95921020403;8180.754577362689;8195.016598008277;7365.7790266292095;7458.142313633893;7478.140013898363;7511.774646760606;7519.699212031457;5099.566536844335;5279.894402112013;5305.734713264322;5319.627626066215;5336.439673834269;1520.7718842173542;1523.4210999819998;1524.9313780879886;1529.915854627984;1536.4468791235147;897.8204359128069;921.9170274675178;921.949292788903;927.452802846324;938.2494004796135;7654.119776225805;7669.38644908406;7672.386209103258;7694.345980591601;7765.883511747328;707.7169132347102;708.592559278417;717.4045542199962;723.0744646852038;728.4754976416971;4760.738159401197;4826.7827947742435;5037.19404895215;5050.84847454577;5213.852952350477;21149.25977590777;22426.775732242793;22562.54874902493;22582.322530324116;22628;21715.23996660141;21735.130594776347;22025.889870550545;22073.448163796034;22291.77708222897;10824.13406927444;10994.175436842108;11012.339259644446;11015.063719583924;11020.338779673246;7767.883481747891;8037.557934313669;8177.6320065596;8374.288185504056;8563.95718021431;18090.81909180944;18338.449846504627;18713.064346782878;18940.715889261395;18999.715004275222;18607.44177674672;19113.426597202106;19142;19488.220471180994;19747.111379988222;11091.112710983263;11246;11249.66251012471;11293.096552275634;11304.604338848101;13291.335433228107;13795.310234488436;13813.447462101403;13815.240161791198;13828.377723002288;11460.863579911464;11648.708782280512;11691.707707307045;11822.586209482626;11878.406079696153;10983.670489885317;11193.216474846682;11372.43137843088;11572.24780389272;11704.590339338083;10121.595136194765;10262;10270.435126068138;10282.177425805769;10319.329243599143;6812.489063320171;6924.4114250289285;6927.203371612329;6929.653517324215;6951.930480695129;6806.76176333826;6975.686094125675;6986.181180083278;6989.752092530863;7018.543794653331 03:48:49 INFO - PID 1885 | |4;prototype.html;506.8099462701487;511.12342332899095;531.2031952071893;535.2017222133632;542.1623591551054;6264.968675156623;6293.15042469266;6365.140706004688;6374.426301632852;6428.678566071701;6261.499080073595;6268.65522396268;6293.27627322858;6308.621482711041;6311.463525600329;5230.8692282692955;5235.476452354772;5236.3978142513715;5249.1338929076655;5260.105782017066;4800.5679488846;5022.4726403727445;5182.818601348954;5212.713300768475;5236.31927849379;4966.776495057731;4968.2795994580765;5017.222330538754;5018.422881368635;5031.748412579374;4915.58217551505;4950.628702847301;4988.376452943382;5012.373453318335;5040.420351659551;4495.123450927071;4495.46054473462;4529.501754806968;4539.228331183674;4566.520515345907;6057.757689692407;6080.2399700037495;6102.42027007438;6131.448169664707;6139.50883929289;5762.279715035621;5766.221560089376;5787.1608616750755;5796.50729687977;5801.216835727165;6537.346265373472;6563.967180164069;6576.210854697419;6591.373819487141;6599.6370199639005;4927.349337971784;4938.777755001033;4939.259111133323;4957.182064959314;4960.528749768766;6634.668266586651;6659.733610655568;6831.009503621947;6858.725650973955;6989.37095661393;5063.164577844688;5070.29015937769;5083.694978301313;5085.669431486942;5108.565771909355;5122.615803814729;5146.433892271847;5157.200633901752;5181.663191892515;5186.688798672092;5697.344805347355;5702.54379649627;5727.284089488814;5729.799457018984;5770.769169233267;6666;6675.46596272297;6676.132102826601;6694.196696396463;6711.3288671132495;1742.3901634428103;1755.1048965027671;1768.2043080613776;1787.25828781057;1793.515750747291;1178.8290697848763;1196.9760604787855;1231.310466138965;1240.1071228715311;1245.8255844181822;5801.738921748447;5805.970970145122;5813.82558523245;5853;5882.205902203234;6695.263521012685;6723.260441351447;6758.330459468482;6777.2545020047755;6831.829204269834;5745.971270143623;5856.912146317809;5857.824265272048;5880.029795083763;5910.261217347832;3495.2834668892815;3549.976513387396;3565.928681426357;3574.6782789549065;3615.692666123409;6495.870082598416;6564.4420224281475;6589.759481776219;6589.835254118685;6611.404973552403;6386.744530218739;6702.229243636946;6811.693473793691;6888.207856096513;6932.48006399512;6567.080608714784;6611.867762644816;6632.668366581748;6637.6681165940545;6707.765228216989;6591.274959754519;6630.569013014138;6637.800865974028;6700.162479690039;6784.929042574416;6673.9666301668185;6696.363845434676;6705.262421133574;6705.362990515893;6710.322419395151;6534.150560427114;6564.179477565304;6597.241317248578;6598.558533342694;6675.7997260082275;5009.474005229544;5012.598992080698;5018.172001619838;5052.797888084436;5072.315237442898;6549.377809108127;6702.631355275506;6761;6851.9657401712675;6861.451083913175;6452.54832161763;6563.540552161303;6586.341365863375;6612.933870661424;6623.735050597922;6580.177477815273;6584.670766461562;6595.175603049619;6600.036961006184;6601.33986601336;6297.181366422519;6376.808695739135;6408.788967806286;6447.194100737408;6458.930873549633;6563.409293163638;6564.800791734822;6619.014295711364;6620.569662971891;6665.3001434850585;6331.96834015827;6336.873262534631;6383.627520083204;6390.7443702251385;6415.701480008499 03:48:49 INFO - PID 1885 | |5;yui.html;895.5925054100381;909.5588639509837;918.0314767919842;920.3603495570582;940.8541676040212;17457.738133927985;17685.20416581252;17706.734398984026;17719;17741;17089.230984605692;17090.572735681584;17171.05559194247;17191.82808171918;17210;944.9716508504756;960.7550074730934;968.9903100969005;970.2286682087722;971.7522031881861;975.7414285214423;979.3878825733916;980.6665733650557;981.3915372469044;981.4798156976779;1002.8896821349646;1035.6116456328878;1037.289456722144;1041.1202533858877;1048.7063622185763;1036.176239889286;1037.6938803053117;1038.1590911361745;1038.3147122898927;1038.3199004651926;722.5159143373952;747.9289467500579;757.4394947738689;760.9010828592303;762.5539059650112;19415.51461213467;19670.213191472325;19715.211391544322;19716.211351546066;19731;20764.896175519025;20962.371128866158;21457.892710536347;21527;21527.56944861094;16699;16897.155142242962;16996.575085622833;17224.48326550193;17287.394941176997;3773.3773927301963;3777.5089238399105;3808.1241314497543;3808.3525800613684;3810.085579460937;100054.49972750162;134409;135651;138573;138855.30572347174;16350.345986160659;16902.154892255337;17025.23386447613;17068;17069.658606827794;31022.844885775427;31598.842005789826;32102.518462223084;32109.197270068435;32160.517592236134;8907.688230911886;9149.679761208326;9201.079892010745;9221.90778092224;9222.40054396462;4137.710360274812;4266.1254442839145;4297.076128632297;4309.28896732042;4311.892202694958;5460.399356070829;5526.171074338801;5564.387917329091;5570.053090974544;5595.776168953278;1064.7125276175389;1086.9891301087046;1103.6082190822142;1104.861892263467;1108.4346983038708;678.111673707435;700.7981312049757;705.35460054051;711.7010855440727;713.5112447973052;11113.388763617917;11626.709332266591;11627.268689711593;12487.125901187012;12878;647.3688154049764;658.3778329478597;666.8166254280112;670.3296703296703;672.6065251827736;5363.490468405495;5465.754041068082;5472;5544.223808666709;5555.444455554412;122749.38625306817;124526;126845;127918.36040819736;130037.34981325033;105355;106991;109170.45414772876;110889.44555277172;114765.4261728686;93537.53231233801;96990;97591.99999999857;98465.50767246119;101060.49469752604;12213.69465763363;12974.026947978751;13022.218666880017;13089.018323625576;13170.143940643828;44526;45961.31058034199;46189.30716039195;46552.7672361636;47086.76456617695;57652;58129;58345;58790.706046469495;59629;17320.740188896925;17636;17742.645147097242;17766.555836104202;17782.91108544449;15975.920120399323;16024.679506410039;16123.274452649424;16209.675806483569;16231.51305460838;16872.156392180586;16933.15334233259;17231.56921076933;17337.826621734126;17385.652286954442;16225.51323460298;16250;16346.754798677792;16462.506124816275;16520.586985325463;16110.838891610934;16125.435609753602;16236;16266.837331626532;16288.755668665217;12412.689682758004;12679.556215532411;12894.097413181362;12907;12948.223106613634;12623.747525049632;12759.48962041545;12859.614211573667;13041.673958151123;13345 03:48:49 INFO - PID 1885 | __end_tp_report 03:48:49 INFO - PID 1885 | __start_cc_report 03:48:49 INFO - PID 1885 | _x_x_mozilla_cycle_collect,306 03:48:49 INFO - PID 1885 | __end_cc_report 03:48:49 INFO - PID 1885 | __startTimestamp1505645329749__endTimestamp 03:48:49 INFO - PID 1885 | 03:48:49 INFO - PID 1885 | ------- Summary: start ------- 03:48:49 INFO - PID 1885 | Number of tests: 6 03:48:49 INFO - PID 1885 | 03:48:49 INFO - PID 1885 | [#0] dojo.html Cycles:165 Average:6182.93 Median:6467.45 stddev:894.90 (13.8%) stddev-sans-first:865.68 03:48:49 INFO - PID 1885 | Values: 3161.1 3162.7 3178.7 3187.1 3190.1 6200.7 6280.2 6285.9 6342.0 6408.9 6210.6 6224.6 6234.0 6254.0 6265.1 5768.5 5814.8 5839.3 5888.7 5893.7 5824.3 5872.4 5884.5 5902.3 5949.7 2.0 5702.7 5721.2 5841.0 5938.9 5774.3 5776.0 5844.3 5850.6 5859.6 5730.0 5752.1 5809.6 5816.1 5816.7 6238.7 6275.9 6292.6 6332.7 6339.4 6702.4 6714.4 6794.9 6798.5 6814.8 6597.3 6800.1 6816.1 6896.0 6904.2 6204.7 6239.7 6314.0 6317.9 6327.0 6996.8 7018.9 7053.4 7055.9 7071.9 6645.9 6652.2 6718.1 6726.1 6731.1 6676.4 6753.9 6760.3 6775.2 6848.6 6714.9 6717.5 6725.9 6732.9 6734.0 6743.5 6777.4 6818.0 6839.7 6843.0 5287.4 5292.2 5349.3 5360.0 5361.5 4481.8 4579.6 4596.7 4622.0 4648.3 5708.0 5768.7 5773.8 5774.0 5814.1 6670.1 6811.3 6841.6 6849.5 6856.5 5833.0 5847.2 5907.1 5908.5 5916.2 5649.9 5667.8 5684.8 5726.2 5836.0 6411.7 6566.6 6578.1 6582.3 6644.7 6750.4 6806.1 6830.0 6861.0 6863.0 6594.8 6618.5 6678.2 6680.4 6685.5 6619.8 6661.7 6709.2 6724.2 6725.2 6540.1 6675.0 6706.1 6782.9 6810.5 6560.6 6573.3 6622.6 6641.1 6647.9 6559.8 6576.3 6622.2 6638.9 6650.7 6466.6 6469.2 6556.1 6563.3 6566.5 6415.4 6507.8 6570.9 6586.6 6680.5 6182.6 6358.2 6404.3 6454.7 6467.5 03:48:49 INFO - PID 1885 | 03:48:49 INFO - PID 1885 | [#1] ext.html Cycles:180 Average:36940.35 Median:19316.13 stddev:51998.30 (269.2%) stddev-sans-first:52073.57 03:48:49 INFO - PID 1885 | Values: 854.6 864.8 879.2 884.0 892.6 41351.6 42409.8 42432.8 42467.0 42535.6 38115.0 38608.4 38617.0 38627.2 38638.2 7007.1 7153.9 7156.4 7168.7 7175.9 6944.8 7015.6 7017.8 7023.9 7039.5 7716.2 7858.2 7871.6 7880.9 7886.4 7759.6 7774.4 7782.7 7826.9 7844.3 7576.7 7762.8 7806.5 7840.9 7843.8 39147.2 39229.2 39303.4 39510.0 39563.8 3526.8 3559.5 3590.4 3595.4 3596.3 31250.9 31304.7 31532.5 31636.5 31725.0 5200.3 5271.5 5321.1 5322.3 5325.3 183946.0 185181.0 190611.0 192101.0 192359.0 43420.6 48816.8 49917.5 49931.3 50055.0 51762.5 51813.2 51828.5 51836.5 51883.0 15313.3 15420.9 15448.2 15467.6 15482.8 12391.9 12452.1 12455.7 12472.1 12474.8 13967.4 14103.4 14384.4 14498.1 14654.8 5787.7 5808.8 5916.6 5933.3 5973.9 1020.8 1027.6 1028.8 1045.5 1047.8 22602.4 23037.8 23068.1 23102.9 23460.4 1123.9 1124.9 1132.3 1161.2 1161.9 11867.8 12185.7 12202.5 12213.2 12218.6 222241.0 223051.0 223259.0 223298.0 223341.0 52823.7 53005.5 53112.7 53118.7 53258.0 1440.7 1464.6 1486.4 1503.3 1508.2 22581.5 22600.2 22692.4 22695.0 22780.5 38011.6 38049.8 38066.2 38073.0 38142.4 187024.0 188039.0 188273.0 189036.0 189537.0 30787.7 31343.0 34535.1 34902.3 35341.3 42465.6 42487.8 42549.8 42836.1 43063.0 32452.4 32483.4 32497.8 32821.7 33173.2 31229.5 31511.2 31559.2 31808.8 32007.0 35024.5 35105.5 35281.0 35315.0 35413.5 30923.7 31181.8 31234.2 31408.8 31462.4 22379.6 22616.9 22802.4 23162.2 23451.6 03:48:49 INFO - PID 1885 | 03:48:49 INFO - PID 1885 | [#2] jquery.html Cycles:180 Average:35088.13 Median:22357.00 stddev:79250.19 (354.5%) stddev-sans-first:79430.07 03:48:49 INFO - PID 1885 | Values: 545.8 549.4 551.3 587.5 592.1 22164.7 22505.2 22714.0 22997.2 23058.7 23745.4 23951.9 24112.3 24159.6 25050.0 6476.8 6686.5 6688.1 6714.7 6722.6 6294.1 6558.1 6641.6 6660.4 6682.4 6514.8 6532.8 6533.5 6534.1 6537.6 6521.0 6523.7 6524.9 6532.3 6538.8 6059.7 6767.4 7075.1 7090.8 7105.6 31475.0 32325.4 32429.5 32445.8 32453.2 2060.3 2086.7 2089.1 2089.7 2092.6 20615.6 20895.7 21245.3 21300.1 21504.4 2561.8 2582.5 2608.3 2642.4 2653.2 118354.4 125478.0 131021.0 135103.0 137000.0 20938.4 21112.8 21818.6 22191.1 22208.8 41840.8 41940.4 41953.6 42163.4 42348.6 11489.3 11894.2 11977.0 12033.8 12068.5 9867.8 9893.0 9972.0 9978.6 9995.3 11419.5 11518.5 11570.7 11675.5 12014.9 4077.9 4423.4 4523.8 4545.4 4570.3 951.8 965.1 972.3 977.3 987.0 19193.7 19329.5 19538.1 19793.8 20097.3 1017.8 1022.1 1022.6 1023.5 1025.3 10744.5 10820.9 10838.4 10915.9 11134.6 460166.0 469291.0 470022.0 480562.0 482694.0 108265.5 110290.4 110342.0 110393.0 111964.0 1026.3 1072.1 1132.9 1145.8 1191.9 20496.2 20787.3 20795.6 20844.9 20866.4 54306.2 54505.0 54651.0 55353.4 57528.0 68920.7 69927.7 70273.6 70889.0 71106.6 18947.1 19122.0 19776.8 20100.5 20292.9 22952.4 23040.5 23068.8 23321.5 23322.1 18159.2 18168.2 18394.6 18424.4 18561.7 15294.0 15558.8 16695.5 17364.6 17443.0 16843.5 17041.3 17152.8 18152.3 18790.2 18567.2 18574.9 18582.3 18618.3 18635.4 16815.4 16901.7 16951.7 17068.4 18037.1 03:48:49 INFO - PID 1885 | 03:48:49 INFO - PID 1885 | [#3] mootools.html Cycles:180 Average:9400.64 Median:14645.07 stddev:6784.91 (46.3%) stddev-sans-first:6776.95 03:48:49 INFO - PID 1885 | Values: 1345.6 1403.7 1405.4 1407.0 1407.5 15090.1 15725.1 15729.3 15753.6 15757.4 15239.9 15317.0 15351.4 15390.2 15427.6 2638.7 2672.2 2707.6 2735.7 2736.6 2643.5 2679.6 2693.4 2693.9 2702.4 2638.0 2647.3 2741.6 2743.8 2749.0 2640.2 2673.7 2683.9 2685.9 2687.6 2675.7 2775.7 2783.9 2786.6 2786.6 15300.0 15394.6 15421.8 15428.8 15439.5 8077.4 8432.0 8434.8 8438.7 8446.3 5560.3 5563.6 5569.8 5742.7 5751.6 1841.5 1864.3 1864.4 1891.8 1902.9 26219.3 26642.9 26798.0 26963.3 27098.7 6948.2 6958.4 7187.1 7196.3 7265.7 17361.5 17373.9 17383.9 17387.2 17396.8 7949.4 8088.3 8158.0 8180.8 8195.0 7365.8 7458.1 7478.1 7511.8 7519.7 5099.6 5279.9 5305.7 5319.6 5336.4 1520.8 1523.4 1524.9 1529.9 1536.4 897.8 921.9 921.9 927.5 938.2 7654.1 7669.4 7672.4 7694.3 7765.9 707.7 708.6 717.4 723.1 728.5 4760.7 4826.8 5037.2 5050.8 5213.9 21149.3 22426.8 22562.5 22582.3 22628.0 21715.2 21735.1 22025.9 22073.4 22291.8 10824.1 10994.2 11012.3 11015.1 11020.3 7767.9 8037.6 8177.6 8374.3 8564.0 18090.8 18338.4 18713.1 18940.7 18999.7 18607.4 19113.4 19142.0 19488.2 19747.1 11091.1 11246.0 11249.7 11293.1 11304.6 13291.3 13795.3 13813.4 13815.2 13828.4 11460.9 11648.7 11691.7 11822.6 11878.4 10983.7 11193.2 11372.4 11572.2 11704.6 10121.6 10262.0 10270.4 10282.2 10319.3 6812.5 6924.4 6927.2 6929.7 6951.9 6806.8 6975.7 6986.2 6989.8 7018.5 03:48:49 INFO - PID 1885 | 03:48:49 INFO - PID 1885 | [#4] prototype.html Cycles:180 Average:5557.16 Median:6263.23 stddev:1548.29 (24.7%) stddev-sans-first:1505.51 03:48:49 INFO - PID 1885 | Values: 506.8 511.1 531.2 535.2 542.2 6265.0 6293.2 6365.1 6374.4 6428.7 6261.5 6268.7 6293.3 6308.6 6311.5 5230.9 5235.5 5236.4 5249.1 5260.1 4800.6 5022.5 5182.8 5212.7 5236.3 4966.8 4968.3 5017.2 5018.4 5031.7 4915.6 4950.6 4988.4 5012.4 5040.4 4495.1 4495.5 4529.5 4539.2 4566.5 6057.8 6080.2 6102.4 6131.4 6139.5 5762.3 5766.2 5787.2 5796.5 5801.2 6537.3 6564.0 6576.2 6591.4 6599.6 4927.3 4938.8 4939.3 4957.2 4960.5 6634.7 6659.7 6831.0 6858.7 6989.4 5063.2 5070.3 5083.7 5085.7 5108.6 5122.6 5146.4 5157.2 5181.7 5186.7 5697.3 5702.5 5727.3 5729.8 5770.8 6666.0 6675.5 6676.1 6694.2 6711.3 1742.4 1755.1 1768.2 1787.3 1793.5 1178.8 1197.0 1231.3 1240.1 1245.8 5801.7 5806.0 5813.8 5853.0 5882.2 6695.3 6723.3 6758.3 6777.3 6831.8 5746.0 5856.9 5857.8 5880.0 5910.3 3495.3 3550.0 3565.9 3574.7 3615.7 6495.9 6564.4 6589.8 6589.8 6611.4 6386.7 6702.2 6811.7 6888.2 6932.5 6567.1 6611.9 6632.7 6637.7 6707.8 6591.3 6630.6 6637.8 6700.2 6784.9 6674.0 6696.4 6705.3 6705.4 6710.3 6534.2 6564.2 6597.2 6598.6 6675.8 5009.5 5012.6 5018.2 5052.8 5072.3 6549.4 6702.6 6761.0 6852.0 6861.5 6452.5 6563.5 6586.3 6612.9 6623.7 6580.2 6584.7 6595.2 6600.0 6601.3 6297.2 6376.8 6408.8 6447.2 6458.9 6563.4 6564.8 6619.0 6620.6 6665.3 6332.0 6336.9 6383.6 6390.7 6415.7 03:48:49 INFO - PID 1885 | 03:48:49 INFO - PID 1885 | [#5] yui.html Cycles:180 Average:24423.67 Median:17712.87 stddev:34980.29 (197.5%) stddev-sans-first:35033.81 03:48:49 INFO - PID 1885 | Values: 895.6 909.6 918.0 920.4 940.9 17457.7 17685.2 17706.7 17719.0 17741.0 17089.2 17090.6 17171.1 17191.8 17210.0 945.0 960.8 969.0 970.2 971.8 975.7 979.4 980.7 981.4 981.5 1002.9 1035.6 1037.3 1041.1 1048.7 1036.2 1037.7 1038.2 1038.3 1038.3 722.5 747.9 757.4 760.9 762.6 19415.5 19670.2 19715.2 19716.2 19731.0 20764.9 20962.4 21457.9 21527.0 21527.6 16699.0 16897.2 16996.6 17224.5 17287.4 3773.4 3777.5 3808.1 3808.4 3810.1 100054.5 134409.0 135651.0 138573.0 138855.3 16350.3 16902.2 17025.2 17068.0 17069.7 31022.8 31598.8 32102.5 32109.2 32160.5 8907.7 9149.7 9201.1 9221.9 9222.4 4137.7 4266.1 4297.1 4309.3 4311.9 5460.4 5526.2 5564.4 5570.1 5595.8 1064.7 1087.0 1103.6 1104.9 1108.4 678.1 700.8 705.4 711.7 713.5 11113.4 11626.7 11627.3 12487.1 12878.0 647.4 658.4 666.8 670.3 672.6 5363.5 5465.8 5472.0 5544.2 5555.4 122749.4 124526.0 126845.0 127918.4 130037.3 105355.0 106991.0 109170.5 110889.4 114765.4 93537.5 96990.0 97592.0 98465.5 101060.5 12213.7 12974.0 13022.2 13089.0 13170.1 44526.0 45961.3 46189.3 46552.8 47086.8 57652.0 58129.0 58345.0 58790.7 59629.0 17320.7 17636.0 17742.6 17766.6 17782.9 15975.9 16024.7 16123.3 16209.7 16231.5 16872.2 16933.2 17231.6 17337.8 17385.7 16225.5 16250.0 16346.8 16462.5 16520.6 16110.8 16125.4 16236.0 16266.8 16288.8 12412.7 12679.6 12894.1 12907.0 12948.2 12623.7 12759.5 12859.6 13041.7 13345.0 03:48:49 INFO - PID 1885 | -------- Summary: end -------- 03:48:49 INFO - PID 1885 | 03:48:50 INFO - TEST-INFO | 1885: exit 0 03:48:50 INFO - TEST-OK | dromaeo_css | took 1108149ms 03:48:50 INFO - TEST-START | kraken 03:48:50 INFO - Initialising browser for kraken test... 03:48:50 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47614/getInfo.html -profile /tmp/tmpKjg7Vx/profile 03:48:50 INFO - TEST-INFO | started process 2255 (/builds/slave/test/build/application/firefox/firefox http://localhost:47614/getInfo.html) 03:48:55 INFO - TEST-INFO | 2255: exit 0 03:48:55 INFO - Browser initialized. 03:48:55 INFO - Running cycle 1/1 for kraken test... 03:48:55 INFO - Using env: {'DISPLAY': ':0', 03:48:55 INFO - 'HOME': '/home/cltbld', 03:48:55 INFO - 'JSGC_DISABLE_POISONING': '1', 03:48:55 INFO - 'LANG': 'en_US.UTF-8', 03:48:55 INFO - 'LANGUAGE': 'en_US:en', 03:48:55 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:48:55 INFO - 'LOGNAME': 'cltbld', 03:48:55 INFO - 'MAIL': '/var/mail/cltbld', 03:48:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:48:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:48:55 INFO - 'MOZ_CRASHREPORTER': '1', 03:48:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:55 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:48:55 INFO - 'MOZ_NO_REMOTE': '1', 03:48:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:48:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:55 INFO - 'NO_EM_RESTART': '1', 03:48:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:55 INFO - 'PWD': '/builds/slave/test', 03:48:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:48:55 INFO - 'RUST_BACKTRACE': 'full', 03:48:55 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:48:55 INFO - 'SHELL': '/bin/bash', 03:48:55 INFO - 'SHLVL': '1', 03:48:55 INFO - 'STYLO_FORCE_DISABLED': '1', 03:48:55 INFO - 'TERM': 'linux', 03:48:55 INFO - 'TMOUT': '86400', 03:48:55 INFO - 'USER': 'cltbld', 03:48:55 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1505643961.634126-1400065840', 03:48:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:55 INFO - '_': '/tools/buildbot/bin/python'} 03:48:55 INFO - TEST-INFO | started process 2482 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKjg7Vx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:48:56 INFO - PID 2482 | 03:48:56 INFO - PID 2482 | (/builds/slave/test/build/application/firefox/firefox:2531): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:48:56 INFO - PID 2482 | 03:49:07 INFO - PID 2482 | RSS: Main: 156921856 03:49:07 INFO - PID 2482 | 03:49:09 INFO - PID 2482 | Cycle 1(1): loaded http://localhost:47614/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47614/tests/kraken/driver.html?testName=audio-beat-detection) 03:49:10 INFO - PID 2482 | RSS: Main: 163598336 03:49:10 INFO - PID 2482 | 03:49:13 INFO - PID 2482 | Cycle 1(1): loaded http://localhost:47614/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47614/tests/kraken/driver.html?testName=audio-dft) 03:49:13 INFO - PID 2482 | RSS: Main: 163303424 03:49:13 INFO - PID 2482 | 03:49:16 INFO - PID 2482 | Cycle 1(1): loaded http://localhost:47614/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47614/tests/kraken/driver.html?testName=audio-fft) 03:49:17 INFO - PID 2482 | RSS: Main: 158973952 03:49:17 INFO - PID 2482 | 03:49:19 INFO - PID 2482 | Cycle 1(1): loaded http://localhost:47614/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47614/tests/kraken/driver.html?testName=audio-oscillator) 03:49:20 INFO - PID 2482 | RSS: Main: 159490048 03:49:20 INFO - PID 2482 | 03:49:22 INFO - PID 2482 | Cycle 1(1): loaded http://localhost:47614/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47614/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:49:22 INFO - PID 2482 | RSS: Main: 159244288 03:49:22 INFO - PID 2482 | 03:49:26 INFO - PID 2482 | Cycle 1(1): loaded http://localhost:47614/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47614/tests/kraken/driver.html?testName=imaging-darkroom) 03:49:26 INFO - PID 2482 | RSS: Main: 162041856 03:49:26 INFO - PID 2482 | 03:49:30 INFO - PID 2482 | Cycle 1(1): loaded http://localhost:47614/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47614/tests/kraken/driver.html?testName=imaging-desaturate) 03:49:30 INFO - PID 2482 | RSS: Main: 162746368 03:49:30 INFO - PID 2482 | 03:49:33 INFO - PID 2482 | Cycle 1(1): loaded http://localhost:47614/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47614/tests/kraken/driver.html?testName=json-parse-financial) 03:49:34 INFO - PID 2482 | RSS: Main: 162390016 03:49:34 INFO - PID 2482 | 03:49:36 INFO - PID 2482 | Cycle 1(1): loaded http://localhost:47614/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47614/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:49:36 INFO - PID 2482 | RSS: Main: 162275328 03:49:36 INFO - PID 2482 | 03:49:38 INFO - PID 2482 | Cycle 1(1): loaded http://localhost:47614/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47614/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:49:39 INFO - PID 2482 | RSS: Main: 162279424 03:49:39 INFO - PID 2482 | 03:49:41 INFO - PID 2482 | Cycle 1(1): loaded http://localhost:47614/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47614/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:49:41 INFO - PID 2482 | RSS: Main: 159059968 03:49:41 INFO - PID 2482 | 03:49:44 INFO - PID 2482 | Cycle 1(1): loaded http://localhost:47614/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47614/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:49:44 INFO - PID 2482 | RSS: Main: 159641600 03:49:44 INFO - PID 2482 | 03:49:47 INFO - PID 2482 | Cycle 1(1): loaded http://localhost:47614/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47614/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:49:48 INFO - PID 2482 | RSS: Main: 159576064 03:49:48 INFO - PID 2482 | 03:49:50 INFO - PID 2482 | Cycle 1(1): loaded http://localhost:47614/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47614/tests/kraken/driver.html?testName=ai-astar) 03:49:50 INFO - PID 2482 | RSS: Main: 160821248 03:49:50 INFO - PID 2482 | 03:49:50 INFO - PID 2482 | __start_tp_report 03:49:50 INFO - PID 2482 | _x_x_mozilla_page_load 03:49:50 INFO - PID 2482 | _x_x_mozilla_page_load_details 03:49:50 INFO - PID 2482 | |i|pagename|runs| 03:49:50 INFO - PID 2482 | |0;ai-astar;110;109;110;109;109;96;108;106;108;110 03:49:50 INFO - PID 2482 | |1;audio-beat-detection;118;121;119;119;116;115;116;117;153;117 03:49:50 INFO - PID 2482 | |2;audio-dft;165;162;162;162;162;163;162;163;165;166 03:49:50 INFO - PID 2482 | |3;audio-fft;75;74;73;76;73;76;74;74;73;74 03:49:50 INFO - PID 2482 | |4;audio-oscillator;80;78;79;84;79;79;79;79;80;78 03:49:50 INFO - PID 2482 | |5;imaging-gaussian-blur;110;113;116;117;117;114;114;117;114;114 03:49:50 INFO - PID 2482 | |6;imaging-darkroom;158;149;147;149;148;149;148;148;151;148 03:49:50 INFO - PID 2482 | |7;imaging-desaturate;102;94;93;98;104;94;94;99;97;94 03:49:50 INFO - PID 2482 | |8;json-parse-financial;55;58;55;53;52;54;54;59;55;55 03:49:50 INFO - PID 2482 | |9;json-stringify-tinderbox;37;37;37;38;38;37;39;39;37;37 03:49:50 INFO - PID 2482 | |10;stanford-crypto-aes;75;73;74;76;74;73;77;74;75;73 03:49:50 INFO - PID 2482 | |11;stanford-crypto-ccm;114;115;117;112;111;115;114;111;120;117 03:49:50 INFO - PID 2482 | |12;stanford-crypto-pbkdf2;183;189;171;167;172;171;170;177;167;168 03:49:50 INFO - PID 2482 | |13;stanford-crypto-sha256-iterative;71;67;69;65;73;66;64;69;67;70 03:49:50 INFO - PID 2482 | __end_tp_report 03:49:50 INFO - PID 2482 | __start_cc_report 03:49:50 INFO - PID 2482 | _x_x_mozilla_cycle_collect,770 03:49:50 INFO - PID 2482 | __end_cc_report 03:49:50 INFO - PID 2482 | __startTimestamp1505645390602__endTimestamp 03:49:50 INFO - PID 2482 | 03:49:50 INFO - PID 2482 | ------- Summary: start ------- 03:49:50 INFO - PID 2482 | Number of tests: 14 03:49:50 INFO - PID 2482 | 03:49:50 INFO - PID 2482 | [#0] ai-astar Cycles:10 Average:107.50 Median:109.50 stddev:4.22 (3.9%) stddev-sans-first:4.38 03:49:50 INFO - PID 2482 | Values: 110.0 109.0 110.0 109.0 109.0 96.0 108.0 106.0 108.0 110.0 03:49:50 INFO - PID 2482 | 03:49:50 INFO - PID 2482 | [#1] audio-beat-detection Cycles:10 Average:121.10 Median:118.50 stddev:11.35 (9.6%) stddev-sans-first:11.98 03:49:50 INFO - PID 2482 | Values: 118.0 121.0 119.0 119.0 116.0 115.0 116.0 117.0 153.0 117.0 03:49:50 INFO - PID 2482 | 03:49:50 INFO - PID 2482 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.00 stddev:1.55 (1.0%) stddev-sans-first:1.50 03:49:50 INFO - PID 2482 | Values: 165.0 162.0 162.0 162.0 162.0 163.0 162.0 163.0 165.0 166.0 03:49:50 INFO - PID 2482 | 03:49:50 INFO - PID 2482 | [#3] audio-fft Cycles:10 Average:74.20 Median:74.00 stddev:1.14 (1.5%) stddev-sans-first:1.17 03:49:50 INFO - PID 2482 | Values: 75.0 74.0 73.0 76.0 73.0 76.0 74.0 74.0 73.0 74.0 03:49:50 INFO - PID 2482 | 03:49:50 INFO - PID 2482 | [#4] audio-oscillator Cycles:10 Average:79.50 Median:79.00 stddev:1.72 (2.2%) stddev-sans-first:1.81 03:49:50 INFO - PID 2482 | Values: 80.0 78.0 79.0 84.0 79.0 79.0 79.0 79.0 80.0 78.0 03:49:50 INFO - PID 2482 | 03:49:50 INFO - PID 2482 | [#5] imaging-gaussian-blur Cycles:10 Average:114.60 Median:115.00 stddev:2.22 (1.9%) stddev-sans-first:1.62 03:49:50 INFO - PID 2482 | Values: 110.0 113.0 116.0 117.0 117.0 114.0 114.0 117.0 114.0 114.0 03:49:50 INFO - PID 2482 | 03:49:50 INFO - PID 2482 | [#6] imaging-darkroom Cycles:10 Average:149.50 Median:149.00 stddev:3.17 (2.1%) stddev-sans-first:1.13 03:49:50 INFO - PID 2482 | Values: 158.0 149.0 147.0 149.0 148.0 149.0 148.0 148.0 151.0 148.0 03:49:50 INFO - PID 2482 | 03:49:50 INFO - PID 2482 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:94.00 stddev:3.81 (4.1%) stddev-sans-first:3.57 03:49:50 INFO - PID 2482 | Values: 102.0 94.0 93.0 98.0 104.0 94.0 94.0 99.0 97.0 94.0 03:49:50 INFO - PID 2482 | 03:49:50 INFO - PID 2482 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.00 stddev:2.11 (3.8%) stddev-sans-first:2.24 03:49:50 INFO - PID 2482 | Values: 55.0 58.0 55.0 53.0 52.0 54.0 54.0 59.0 55.0 55.0 03:49:50 INFO - PID 2482 | 03:49:50 INFO - PID 2482 | [#9] json-stringify-tinderbox Cycles:10 Average:37.60 Median:37.50 stddev:0.84 (2.2%) stddev-sans-first:0.87 03:49:50 INFO - PID 2482 | Values: 37.0 37.0 37.0 38.0 38.0 37.0 39.0 39.0 37.0 37.0 03:49:50 INFO - PID 2482 | 03:49:50 INFO - PID 2482 | [#10] stanford-crypto-aes Cycles:10 Average:74.40 Median:74.50 stddev:1.35 (1.8%) stddev-sans-first:1.41 03:49:50 INFO - PID 2482 | Values: 75.0 73.0 74.0 76.0 74.0 73.0 77.0 74.0 75.0 73.0 03:49:50 INFO - PID 2482 | 03:49:50 INFO - PID 2482 | [#11] stanford-crypto-ccm Cycles:10 Average:114.60 Median:115.00 stddev:2.88 (2.5%) stddev-sans-first:3.04 03:49:50 INFO - PID 2482 | Values: 114.0 115.0 117.0 112.0 111.0 115.0 114.0 111.0 120.0 117.0 03:49:50 INFO - PID 2482 | 03:49:50 INFO - PID 2482 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.50 Median:171.50 stddev:7.34 (4.3%) stddev-sans-first:6.93 03:49:50 INFO - PID 2482 | Values: 183.0 189.0 171.0 167.0 172.0 171.0 170.0 177.0 167.0 168.0 03:49:50 INFO - PID 2482 | 03:49:50 INFO - PID 2482 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:69.00 stddev:2.81 (4.1%) stddev-sans-first:2.77 03:49:50 INFO - PID 2482 | Values: 71.0 67.0 69.0 65.0 73.0 66.0 64.0 69.0 67.0 70.0 03:49:50 INFO - PID 2482 | -------- Summary: end -------- 03:49:50 INFO - PID 2482 | 03:49:50 INFO - PID 2482 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:49:51 INFO - TEST-INFO | 2482: exit 0 03:49:51 INFO - TEST-OK | kraken | took 60730ms 03:49:51 INFO - SUITE-END | took 1168s 03:49:51 INFO - Completed test suite (00:19:28) 03:49:51 INFO - javascript benchmark 03:49:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8624.4083718813, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3161.067485091899, 3162.6995435433632, 3178.6821317868207, 3187.091678871522, 3190.0589326148784, 6200.720967556459, 6280.214973128359, 6285.905711414327, 6341.968290158555, 6408.871822563552, 6210.565260431772, 6224.626522408658, 6234.033724772657, 6254.030625253082, 6265.060240963858, 5768.538516918637, 5814.767409303644, 5839.328477225131, 5888.676122813244, 5893.705314734268, 5824.301083869942, 5872.354041055481, 5884.4703976642095, 5902.2622172228475, 5949.702514874239, 1.9786251946825855, 5702.714864256791, 5721.170430287606, 5841.0362290222065, 5938.910916336258, 5774.335951365605, 5776.046952252873, 5844.298684157886, 5850.561207909382, 5859.648421094706, 5730.025895597759, 5752.050911599581, 5809.564282678816, 5816.1275808628625, 5816.738246778905, 6238.688065596747, 6275.8744825103695, 6292.62244265341, 6332.651704156269, 6339.397757213057, 6702.396784289437, 6714.429273511757, 6794.946783248604, 6798.456123510107, 6814.761483348108, 6597.340265973412, 6800.081988931481, 6816.113905192294, 6896.0, 6904.171499420051, 6204.6587437690905, 6239.65681887496, 6313.968430157865, 6317.93682063178, 6327.019312006601, 6996.825079373006, 7018.859622807618, 7053.435725141976, 7055.89416158758, 7071.8939215911805, 6645.867082658319, 6652.168478940132, 6718.126643536309, 6726.058351830748, 6731.057651928734, 6676.399124078759, 6753.898691519631, 6760.256371799098, 6775.22084960226, 6848.623325717133, 6714.899276510856, 6717.496187785936, 6725.932740672629, 6732.932670673231, 6734.023566582818, 6743.460523158135, 6777.390034896883, 6818.0, 6839.726410943506, 6843.0419741236265, 5287.365516138088, 5292.153255479105, 5349.277847490617, 5359.973200134053, 5361.544268737123, 4481.775911204427, 4579.587837094611, 4596.701214421052, 4622.0, 4648.3259927310355, 5708.0, 5768.653880767168, 5773.769049237983, 5774.04728219839, 5814.098814683731, 6670.0661907333015, 6811.25076241613, 6841.62371069586, 6849.486288528281, 6856.485763567653, 5833.0375488044, 5847.181394604759, 5907.113932910098, 5908.527317814651, 5916.201312822714, 5649.858753531194, 5667.829965101054, 5684.8294551163535, 5726.169705392778, 5836.0, 6411.67941602918, 6566.638834864033, 6578.144841170617, 6582.308857569887, 6644.700988455531, 6750.392464678006, 6806.149231346082, 6830.043793868862, 6860.965695171492, 6862.965685171642, 6594.802155935329, 6618.503612229006, 6678.23200331968, 6680.3987641112535, 6685.53201275906, 6619.768308109193, 6661.733530658719, 6709.194896612437, 6724.159480064992, 6725.226598940989, 6540.051692504465, 6674.966625166843, 6706.128203333536, 6782.8643427132165, 6810.489213309121, 6560.639164845979, 6573.276939536743, 6622.569532980341, 6641.136652235178, 6647.867042659023, 6559.8032059038305, 6576.2766095728475, 6622.1722284714415, 6638.933610663831, 6650.700718467778, 6466.644334561456, 6469.159009328757, 6556.082148499118, 6563.310852360433, 6566.474682025522, 6415.358464153547, 6507.772227971998, 6570.868582628225, 6586.604803711793, 6680.4989625779235, 6182.567220294536, 6358.205224346957, 6404.263509696445, 6454.741810327534, 6467.450266727381], "value": 6118.718456398717, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [854.5684429363171, 864.7708357285317, 879.2306731609839, 884.0364003236471, 892.5894088719185, 41351.58648413515, 42409.7879510602, 42432.78783606078, 42467.0, 42535.57464425359, 38115.04712382192, 38608.420873686846, 38617.0, 38627.22745545088, 38638.22723545528, 7007.054047703558, 7153.89269160963, 7156.391706704936, 7168.749093781718, 7175.89236161458, 6944.826379340507, 7015.579065256075, 7017.789466316019, 7023.859522809541, 7039.472039597025, 7716.151223365426, 7858.214178582153, 7871.645775940096, 7880.881786773203, 7886.408519361043, 7759.6120193990355, 7774.416918731061, 7782.688692452295, 7826.882596761025, 7844.254795794391, 7576.696932122709, 7762.844743105106, 7806.531608103532, 7840.921590784076, 7843.764687059397, 39147.21705565901, 39229.21541569153, 39303.41044884329, 39510.0, 39563.8021809892, 3526.7883926964464, 3559.519464872235, 3590.3716849551224, 3595.352836489431, 3596.2627661329366, 31250.90621828248, 31304.686953130633, 31532.527012094837, 31636.525452118236, 31725.04824855258, 5200.323957885488, 5271.472852714736, 5321.095413779667, 5322.281491998569, 5325.334333208349, 183946.0, 185180.99999999866, 190611.0, 192101.0, 192359.0, 43420.565794342285, 48816.755916220194, 49917.500824991286, 49931.25103123456, 50055.0, 51762.48237517652, 51813.222801658005, 51828.48171518312, 51836.48163518317, 51883.0, 15313.310901009481, 15420.922895385676, 15448.227588620524, 15467.613309667124, 15482.84517154814, 12391.93804030974, 12452.128351015343, 12455.688607784878, 12472.126951113516, 12474.75050498985, 13967.37146828395, 14103.365348559135, 14384.424623014962, 14498.11524501808, 14654.780178297335, 5787.71061446926, 5808.82573522795, 5916.5858389913155, 5933.2880054393745, 5973.850653733692, 1020.806046851096, 1027.5992362978295, 1028.753099256173, 1045.482486169351, 1047.759015426441, 22602.434939126655, 23037.769622303564, 23068.077276909073, 23102.884485577466, 23460.413489662897, 1123.9438028098562, 1124.8515335708757, 1132.335466863709, 1161.1697636190165, 1161.924474909128, 11867.762644747057, 12185.69535761613, 12202.450889709808, 12213.206141600767, 12218.572349967708, 222241.0, 223051.0, 223259.0, 223298.0, 223341.0, 52823.73588132035, 53005.46994530082, 53112.73443632757, 53118.73440632772, 53258.0, 1440.719059783332, 1464.5899148238511, 1486.3831509923477, 1503.3084781000643, 1508.2157278215266, 22581.548369032855, 22600.208992685177, 22692.432689182904, 22695.0, 22780.544389111794, 38011.61988380191, 38049.80975095107, 38066.238675226894, 38073.0, 38142.42786358263, 187024.0, 188039.0, 188273.0, 189036.0, 189537.0, 30787.692123079378, 31343.0, 34535.136621584665, 34902.30195396129, 35341.29317413689, 42465.5753442474, 42487.787561061996, 42549.78725106355, 42836.14327713491, 43063.0, 32452.35095298128, 32483.350332992733, 32497.837510812296, 32821.671783282814, 33173.17067073246, 31229.531557027116, 31511.21221969469, 31559.21101972377, 31808.840955795073, 32007.0, 35024.474632881036, 35105.473417899266, 35281.0, 35315.0, 35413.46879796857, 30923.69076309208, 31181.84409078031, 31234.21914452157, 31408.842955785076, 31462.370752585277, 22379.552408951404, 22616.886915565316, 22802.42993925099, 23162.1893233736, 23451.648225276294], "value": 17034.050188073612, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.7980547197537, 549.4148731600844, 551.2640624765935, 587.5064945445826, 592.1325258496302, 22164.667529987044, 22505.212317568887, 22714.0, 22997.195098171567, 23058.65412018821, 23745.40636484089, 23951.880240598817, 24112.276631701076, 24159.63760543593, 25050.0, 6476.773312934049, 6686.498512611549, 6688.0971068905565, 6714.731410743564, 6722.630255335955, 6294.055891616248, 6558.081868538408, 6641.568298060611, 6660.367265109807, 6682.365175308338, 6514.827331080403, 6532.836679083013, 6533.542652014361, 6534.117894084286, 6537.5750576212395, 6521.0, 6523.673816309166, 6524.93475065248, 6532.281449040578, 6538.836529086763, 6059.697015149225, 6767.390934815841, 7075.080239568823, 7090.822729431754, 7105.573665580082, 31475.0, 32325.35349293001, 32429.51355729666, 32445.83777081123, 32453.188670283194, 2060.2789023841538, 2086.7495900491886, 2089.0912453082806, 2089.7387826521685, 2092.5501017281204, 20615.5876882463, 20895.68656470154, 21245.25641602552, 21300.147994080216, 21504.354869353945, 2561.8462892226526, 2582.535143674138, 2608.282722251377, 2642.3526236072285, 2653.2173008962404, 118354.40822795917, 125478.0, 131021.0, 135103.0, 136999.999999999, 20938.37184884456, 21112.78887211139, 21818.563628727337, 22191.115155029744, 22208.77791222067, 41840.790796046436, 41940.37089443661, 41953.580464194965, 42163.367549486786, 42348.57651423508, 11489.253198542068, 11894.167408281337, 11977.0, 12033.759324813629, 12068.517259309705, 9867.802643947225, 9893.0, 9972.002799720116, 9978.600855965826, 9995.300328976902, 11419.48612312448, 11518.481668324945, 11570.710732231762, 11675.532978680758, 12014.939925300492, 4077.89805254871, 4423.380726698265, 4523.796429160696, 4545.36364908913, 4570.291604801261, 951.8477043672979, 965.0542468381026, 972.2999440402899, 977.3354119199013, 986.9851952220722, 19193.712094318595, 19329.47722799954, 19538.12078456473, 19793.802061979484, 20097.29659461941, 1017.8218811707922, 1022.0801278848946, 1022.5909636145601, 1023.4729114506035, 1025.3130402630106, 10744.516496757664, 10820.94589527063, 10838.42842787807, 10915.890841091647, 11134.554617815358, 460166.0, 469291.0, 470022.0, 480562.0, 482694.0, 108265.45867270613, 110290.44854775675, 110342.0, 110393.0, 111964.0, 1026.2610920137488, 1072.126217133034, 1132.92069555132, 1145.7823013627385, 1191.940402979865, 20496.18015279372, 20787.272445464336, 20795.58408831845, 20844.895775521025, 20866.37400877976, 54306.18540721813, 54505.0, 54651.0, 55353.44646553644, 57528.0, 68920.6553967247, 69927.65036174786, 70273.64863175651, 70889.0, 71106.64446677733, 18947.147378367732, 19122.0, 19776.813391196574, 20100.497487562927, 20292.89853550782, 22952.4261893454, 23040.539189215786, 23068.769312306664, 23321.533569328178, 23322.067117315117, 18159.182836772114, 18168.182431790337, 18394.595510208404, 18424.35514756977, 18561.721574176667, 15294.00588961714, 15558.766618500506, 16695.49913502597, 17364.56588585245, 17443.040632765318, 16843.494695159166, 17041.318347266468, 17152.828471715624, 18152.27390904349, 18790.15444304982, 18567.16447759881, 18574.907125464288, 18582.25670973146, 18618.348357807954, 18635.44093677192, 16815.41146059882, 16901.661966760843, 16951.745723814398, 17068.402605908734, 18037.098145092954], "value": 12837.316992274524, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1345.6030471011052, 1403.7473254814136, 1405.423776251737, 1407.0432106167802, 1407.486267512358, 15090.094594324348, 15725.056496610212, 15729.292181851815, 15753.606159845995, 15757.369705211791, 15239.923800380982, 15317.0, 15351.385944562233, 15390.15354155521, 15427.614309642264, 2638.7229340919216, 2672.2384120525653, 2707.553253713135, 2735.726427357268, 2736.5621500559914, 2643.4977354302623, 2679.6114563388296, 2693.4343787804582, 2693.9326516837136, 2702.3784529558216, 2637.997560926845, 2647.272000199941, 2741.643586333774, 2743.8353698778037, 2748.9862550687317, 2640.2079376187257, 2673.70589235184, 2683.8523881186525, 2685.925629748097, 2687.583424569195, 2675.745804148622, 2775.680796708364, 2783.9443211135663, 2786.5541513357966, 2786.6238057862133, 15300.0, 15394.615134621612, 15421.845781542266, 15428.845711542854, 15439.459618913397, 8077.394195435366, 8431.95784021076, 8434.831303373898, 8438.704645337446, 8446.324294056461, 5560.277163968658, 5563.582731295169, 5569.777208911639, 5742.7415766290615, 5751.597388182829, 1841.484384372378, 1864.3008871673123, 1864.4499872537633, 1891.7919028906808, 1902.9429117126508, 26219.344516387053, 26642.86678566595, 26798.0, 26963.325916852235, 27098.729012709817, 6948.235694073648, 6958.408535274457, 7187.065681461377, 7196.280371962762, 7265.745698900513, 17361.47915562535, 17373.913130434266, 17383.91308043452, 17387.21757520889, 17396.82603173952, 7949.443538952333, 8088.272055515032, 8157.95921020403, 8180.754577362689, 8195.016598008277, 7365.7790266292095, 7458.142313633893, 7478.140013898363, 7511.774646760606, 7519.699212031457, 5099.566536844335, 5279.894402112013, 5305.734713264322, 5319.627626066215, 5336.439673834269, 1520.7718842173542, 1523.4210999819998, 1524.9313780879886, 1529.915854627984, 1536.4468791235147, 897.8204359128069, 921.9170274675178, 921.949292788903, 927.452802846324, 938.2494004796135, 7654.119776225805, 7669.38644908406, 7672.386209103258, 7694.345980591601, 7765.883511747328, 707.7169132347102, 708.592559278417, 717.4045542199962, 723.0744646852038, 728.4754976416971, 4760.738159401197, 4826.7827947742435, 5037.19404895215, 5050.84847454577, 5213.852952350477, 21149.25977590777, 22426.775732242793, 22562.54874902493, 22582.322530324116, 22628.0, 21715.23996660141, 21735.130594776347, 22025.889870550545, 22073.448163796034, 22291.77708222897, 10824.13406927444, 10994.175436842108, 11012.339259644446, 11015.063719583924, 11020.338779673246, 7767.883481747891, 8037.557934313669, 8177.6320065596, 8374.288185504056, 8563.95718021431, 18090.81909180944, 18338.449846504627, 18713.064346782878, 18940.715889261395, 18999.715004275222, 18607.44177674672, 19113.426597202106, 19142.0, 19488.220471180994, 19747.111379988222, 11091.112710983263, 11246.0, 11249.66251012471, 11293.096552275634, 11304.604338848101, 13291.335433228107, 13795.310234488436, 13813.447462101403, 13815.240161791198, 13828.377723002288, 11460.863579911464, 11648.708782280512, 11691.707707307045, 11822.586209482626, 11878.406079696153, 10983.670489885317, 11193.216474846682, 11372.43137843088, 11572.24780389272, 11704.590339338083, 10121.595136194765, 10262.0, 10270.435126068138, 10282.177425805769, 10319.329243599143, 6812.489063320171, 6924.4114250289285, 6927.203371612329, 6929.653517324215, 6951.930480695129, 6806.76176333826, 6975.686094125675, 6986.181180083278, 6989.752092530863, 7018.543794653331], "value": 6653.3016881641115, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [506.8099462701487, 511.12342332899095, 531.2031952071893, 535.2017222133632, 542.1623591551054, 6264.968675156623, 6293.15042469266, 6365.140706004688, 6374.426301632852, 6428.678566071701, 6261.499080073595, 6268.65522396268, 6293.27627322858, 6308.621482711041, 6311.463525600329, 5230.8692282692955, 5235.476452354772, 5236.3978142513715, 5249.1338929076655, 5260.105782017066, 4800.5679488846, 5022.4726403727445, 5182.818601348954, 5212.713300768475, 5236.31927849379, 4966.776495057731, 4968.2795994580765, 5017.222330538754, 5018.422881368635, 5031.748412579374, 4915.58217551505, 4950.628702847301, 4988.376452943382, 5012.373453318335, 5040.420351659551, 4495.123450927071, 4495.46054473462, 4529.501754806968, 4539.228331183674, 4566.520515345907, 6057.757689692407, 6080.2399700037495, 6102.42027007438, 6131.448169664707, 6139.50883929289, 5762.279715035621, 5766.221560089376, 5787.1608616750755, 5796.50729687977, 5801.216835727165, 6537.346265373472, 6563.967180164069, 6576.210854697419, 6591.373819487141, 6599.6370199639005, 4927.349337971784, 4938.777755001033, 4939.259111133323, 4957.182064959314, 4960.528749768766, 6634.668266586651, 6659.733610655568, 6831.009503621947, 6858.725650973955, 6989.37095661393, 5063.164577844688, 5070.29015937769, 5083.694978301313, 5085.669431486942, 5108.565771909355, 5122.615803814729, 5146.433892271847, 5157.200633901752, 5181.663191892515, 5186.688798672092, 5697.344805347355, 5702.54379649627, 5727.284089488814, 5729.799457018984, 5770.769169233267, 6666.0, 6675.46596272297, 6676.132102826601, 6694.196696396463, 6711.3288671132495, 1742.3901634428103, 1755.1048965027671, 1768.2043080613776, 1787.25828781057, 1793.515750747291, 1178.8290697848763, 1196.9760604787855, 1231.310466138965, 1240.1071228715311, 1245.8255844181822, 5801.738921748447, 5805.970970145122, 5813.82558523245, 5853.0, 5882.205902203234, 6695.263521012685, 6723.260441351447, 6758.330459468482, 6777.2545020047755, 6831.829204269834, 5745.971270143623, 5856.912146317809, 5857.824265272048, 5880.029795083763, 5910.261217347832, 3495.2834668892815, 3549.976513387396, 3565.928681426357, 3574.6782789549065, 3615.692666123409, 6495.870082598416, 6564.4420224281475, 6589.759481776219, 6589.835254118685, 6611.404973552403, 6386.744530218739, 6702.229243636946, 6811.693473793691, 6888.207856096513, 6932.48006399512, 6567.080608714784, 6611.867762644816, 6632.668366581748, 6637.6681165940545, 6707.765228216989, 6591.274959754519, 6630.569013014138, 6637.800865974028, 6700.162479690039, 6784.929042574416, 6673.9666301668185, 6696.363845434676, 6705.262421133574, 6705.362990515893, 6710.322419395151, 6534.150560427114, 6564.179477565304, 6597.241317248578, 6598.558533342694, 6675.7997260082275, 5009.474005229544, 5012.598992080698, 5018.172001619838, 5052.797888084436, 5072.315237442898, 6549.377809108127, 6702.631355275506, 6761.0, 6851.9657401712675, 6861.451083913175, 6452.54832161763, 6563.540552161303, 6586.341365863375, 6612.933870661424, 6623.735050597922, 6580.177477815273, 6584.670766461562, 6595.175603049619, 6600.036961006184, 6601.33986601336, 6297.181366422519, 6376.808695739135, 6408.788967806286, 6447.194100737408, 6458.930873549633, 6563.409293163638, 6564.800791734822, 6619.014295711364, 6620.569662971891, 6665.3001434850585, 6331.96834015827, 6336.873262534631, 6383.627520083204, 6390.7443702251385, 6415.701480008499], "value": 5101.3075182490875, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [895.5925054100381, 909.5588639509837, 918.0314767919842, 920.3603495570582, 940.8541676040212, 17457.738133927985, 17685.20416581252, 17706.734398984026, 17719.0, 17741.0, 17089.230984605692, 17090.572735681584, 17171.05559194247, 17191.82808171918, 17210.0, 944.9716508504756, 960.7550074730934, 968.9903100969005, 970.2286682087722, 971.7522031881861, 975.7414285214423, 979.3878825733916, 980.6665733650557, 981.3915372469044, 981.4798156976779, 1002.8896821349646, 1035.6116456328878, 1037.289456722144, 1041.1202533858877, 1048.7063622185763, 1036.176239889286, 1037.6938803053117, 1038.1590911361745, 1038.3147122898927, 1038.3199004651926, 722.5159143373952, 747.9289467500579, 757.4394947738689, 760.9010828592303, 762.5539059650112, 19415.51461213467, 19670.213191472325, 19715.211391544322, 19716.211351546066, 19731.0, 20764.896175519025, 20962.371128866158, 21457.892710536347, 21527.0, 21527.56944861094, 16699.0, 16897.155142242962, 16996.575085622833, 17224.48326550193, 17287.394941176997, 3773.3773927301963, 3777.5089238399105, 3808.1241314497543, 3808.3525800613684, 3810.085579460937, 100054.49972750162, 134409.0, 135651.0, 138573.0, 138855.30572347174, 16350.345986160659, 16902.154892255337, 17025.23386447613, 17068.0, 17069.658606827794, 31022.844885775427, 31598.842005789826, 32102.518462223084, 32109.197270068435, 32160.517592236134, 8907.688230911886, 9149.679761208326, 9201.079892010745, 9221.90778092224, 9222.40054396462, 4137.710360274812, 4266.1254442839145, 4297.076128632297, 4309.28896732042, 4311.892202694958, 5460.399356070829, 5526.171074338801, 5564.387917329091, 5570.053090974544, 5595.776168953278, 1064.7125276175389, 1086.9891301087046, 1103.6082190822142, 1104.861892263467, 1108.4346983038708, 678.111673707435, 700.7981312049757, 705.35460054051, 711.7010855440727, 713.5112447973052, 11113.388763617917, 11626.709332266591, 11627.268689711593, 12487.125901187012, 12878.0, 647.3688154049764, 658.3778329478597, 666.8166254280112, 670.3296703296703, 672.6065251827736, 5363.490468405495, 5465.754041068082, 5472.0, 5544.223808666709, 5555.444455554412, 122749.38625306817, 124526.0, 126845.0, 127918.36040819736, 130037.34981325033, 105355.0, 106991.0, 109170.45414772876, 110889.44555277172, 114765.4261728686, 93537.53231233801, 96990.0, 97591.99999999857, 98465.50767246119, 101060.49469752604, 12213.69465763363, 12974.026947978751, 13022.218666880017, 13089.018323625576, 13170.143940643828, 44526.0, 45961.31058034199, 46189.30716039195, 46552.7672361636, 47086.76456617695, 57652.0, 58129.0, 58345.0, 58790.706046469495, 59629.0, 17320.740188896925, 17636.0, 17742.645147097242, 17766.555836104202, 17782.91108544449, 15975.920120399323, 16024.679506410039, 16123.274452649424, 16209.675806483569, 16231.51305460838, 16872.156392180586, 16933.15334233259, 17231.56921076933, 17337.826621734126, 17385.652286954442, 16225.51323460298, 16250.0, 16346.754798677792, 16462.506124816275, 16520.586985325463, 16110.838891610934, 16125.435609753602, 16236.0, 16266.837331626532, 16288.755668665217, 12412.689682758004, 12679.556215532411, 12894.097413181362, 12907.0, 12948.223106613634, 12623.747525049632, 12759.48962041545, 12859.614211573667, 13041.673958151123, 13345.0], "value": 9061.038950612132, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1429.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 109.0, 110.0, 109.0, 109.0, 96.0, 108.0, 106.0, 108.0, 110.0], "value": 107.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 121.0, 119.0, 119.0, 116.0, 115.0, 116.0, 117.0, 153.0, 117.0], "value": 121.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 162.0, 162.0, 162.0, 163.0, 162.0, 163.0, 165.0, 166.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 73.0, 76.0, 73.0, 76.0, 74.0, 74.0, 73.0, 74.0], "value": 74.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 79.0, 84.0, 79.0, 79.0, 79.0, 79.0, 80.0, 78.0], "value": 79.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 116.0, 117.0, 117.0, 114.0, 114.0, 117.0, 114.0, 114.0], "value": 114.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 149.0, 147.0, 149.0, 148.0, 149.0, 148.0, 148.0, 151.0, 148.0], "value": 149.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 94.0, 93.0, 98.0, 104.0, 94.0, 94.0, 99.0, 97.0, 94.0], "value": 96.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 58.0, 55.0, 53.0, 52.0, 54.0, 54.0, 59.0, 55.0, 55.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 37.0, 37.0, 38.0, 38.0, 37.0, 39.0, 39.0, 37.0, 37.0], "value": 37.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 74.0, 76.0, 74.0, 73.0, 77.0, 74.0, 75.0, 73.0], "value": 74.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 117.0, 112.0, 111.0, 115.0, 114.0, 111.0, 120.0, 117.0], "value": 114.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 189.0, 171.0, 167.0, 172.0, 171.0, 170.0, 177.0, 167.0, 168.0], "value": 173.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 67.0, 69.0, 65.0, 73.0, 66.0, 64.0, 69.0, 67.0, 70.0], "value": 68.1, "unit": "score"}]}]} 03:49:51 INFO - Return code: 0 03:49:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:49:51 INFO - # TBPL SUCCESS # 03:49:51 INFO - Running post-action listener: _package_coverage_data 03:49:51 INFO - Running post-action listener: _resource_record_post_action 03:49:51 INFO - [mozharness: 2017-09-17 10:49:51.366158Z] Finished run-tests step (success) 03:49:51 INFO - Running post-run listener: _resource_record_post_run 03:49:51 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 347889664; Read time: 16; Write time: 251504 03:49:51 INFO - TinderboxPrint: CPU usage
13.1% 03:49:51 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 03:49:51 INFO - TinderboxPrint: I/O write bytes / time
347,889,664 / 251,504 03:49:51 INFO - TinderboxPrint: CPU idle
8,223.0 (86.9%) 03:49:51 INFO - TinderboxPrint: CPU user
1,190.0 (12.6%) 03:49:51 INFO - TinderboxPrint: Swap in / out
0 / 0 03:49:51 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13144064; Read time: 0; Write time: 1056 03:49:51 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:49:51 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 0; Write bytes: 334745600; Read time: 0; Write time: 250448 03:49:51 INFO - Running post-run listener: _upload_blobber_files 03:49:51 INFO - Blob upload gear active. 03:49:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:49:51 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 03:49:51 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'] 03:49:51 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 03:49:52 INFO - (blobuploader) - INFO - Open directory for files ... 03:49:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 03:49:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 03:49:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:53 INFO - (blobuploader) - INFO - Done attempting. 03:49:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:49:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:54 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:49:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:54 INFO - (blobuploader) - INFO - Done attempting. 03:49:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 03:49:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 03:49:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:55 INFO - (blobuploader) - INFO - Done attempting. 03:49:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:49:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:50:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:50:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:50:02 INFO - (blobuploader) - INFO - Done attempting. 03:50:02 INFO - (blobuploader) - INFO - Iteration through files over. 03:50:02 INFO - Return code: 0 03:50:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:50:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:50:02 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/580e49dfba8d053b2a48a85e954dce2746a726b573efb11f97e0d9036ef7bfd9c277a4407bd84937f67c16e1ea971d5c24b655870a7ee25227cb7c3469cff077", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f41d8659fa84e48cc49251b7b75a43891409d54bb88b4277ea8509ecbb3cbe35228c1b4fa898d21705eb356e1cc730f2e3ecbd1f35c5e46bcf1abefea34c51ae", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5e0ab331663359111f895d16cdb9392c1073763defc9d018979e1133b42d85d2807cafbaac41cdcf28079cbe1320825bb23aae03027af442dde4e0d8acbf43c6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/af524a62f1beec13ac8744d764dbf874c747b2f3159070e1ae75ba8db9fd8136c347c4cd5b0423fc4d7d98b732d69c8bfe2f4dacea45b0e1b3e2332c130088a3"} 03:50:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:50:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:50:02 INFO - Contents: 03:50:02 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/580e49dfba8d053b2a48a85e954dce2746a726b573efb11f97e0d9036ef7bfd9c277a4407bd84937f67c16e1ea971d5c24b655870a7ee25227cb7c3469cff077", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f41d8659fa84e48cc49251b7b75a43891409d54bb88b4277ea8509ecbb3cbe35228c1b4fa898d21705eb356e1cc730f2e3ecbd1f35c5e46bcf1abefea34c51ae", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5e0ab331663359111f895d16cdb9392c1073763defc9d018979e1133b42d85d2807cafbaac41cdcf28079cbe1320825bb23aae03027af442dde4e0d8acbf43c6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/af524a62f1beec13ac8744d764dbf874c747b2f3159070e1ae75ba8db9fd8136c347c4cd5b0423fc4d7d98b732d69c8bfe2f4dacea45b0e1b3e2332c130088a3"} 03:50:02 INFO - Running post-run listener: copy_logs_to_upload_dir 03:50:02 INFO - Copying logs to upload dir... 03:50:02 INFO - mkdir: /builds/slave/test/build/upload/logs 03:50:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.907643 ========= master_lag: 0.21 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-09-17 03:50:02.559336) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-17 03:50:02.567341) ========= 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=c6927cf182745ad25b1d38b9000001fe-1505643961.634126-1400065840 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/580e49dfba8d053b2a48a85e954dce2746a726b573efb11f97e0d9036ef7bfd9c277a4407bd84937f67c16e1ea971d5c24b655870a7ee25227cb7c3469cff077", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f41d8659fa84e48cc49251b7b75a43891409d54bb88b4277ea8509ecbb3cbe35228c1b4fa898d21705eb356e1cc730f2e3ecbd1f35c5e46bcf1abefea34c51ae", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5e0ab331663359111f895d16cdb9392c1073763defc9d018979e1133b42d85d2807cafbaac41cdcf28079cbe1320825bb23aae03027af442dde4e0d8acbf43c6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/af524a62f1beec13ac8744d764dbf874c747b2f3159070e1ae75ba8db9fd8136c347c4cd5b0423fc4d7d98b732d69c8bfe2f4dacea45b0e1b3e2332c130088a3"} build_url:https://queue.taskcluster.net/v1/task/OSv4zTzPSF2AmqFHfdlHSQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011587 build_url: 'https://queue.taskcluster.net/v1/task/OSv4zTzPSF2AmqFHfdlHSQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/580e49dfba8d053b2a48a85e954dce2746a726b573efb11f97e0d9036ef7bfd9c277a4407bd84937f67c16e1ea971d5c24b655870a7ee25227cb7c3469cff077", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f41d8659fa84e48cc49251b7b75a43891409d54bb88b4277ea8509ecbb3cbe35228c1b4fa898d21705eb356e1cc730f2e3ecbd1f35c5e46bcf1abefea34c51ae", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5e0ab331663359111f895d16cdb9392c1073763defc9d018979e1133b42d85d2807cafbaac41cdcf28079cbe1320825bb23aae03027af442dde4e0d8acbf43c6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/af524a62f1beec13ac8744d764dbf874c747b2f3159070e1ae75ba8db9fd8136c347c4cd5b0423fc4d7d98b732d69c8bfe2f4dacea45b0e1b3e2332c130088a3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-17 03:50:02.601128) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 03:50:02.601536) ========= 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=c6927cf182745ad25b1d38b9000001fe-1505643961.634126-1400065840 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004439 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 03:50:02.685970) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-17 03:50:02.686403) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-17 03:50:02.686821) ========= ========= Total master_lag: 0.48 =========