builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-028 starttime: 1506002606.29 results: success (0) revision: 9caeafcec9982be90820e30bc699e851cb6af907 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-21 07:03:26.293354) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-21 07:03:26.293811) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-21 07:03:26.294087) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-21 07:03:26.339484) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 07:03:26.339844) ========= 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=836cfdc75598d54cb747368e000001a9-1506002068.466600-826066333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-21 07:03:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 227M=0s 2017-09-21 07:03:26 (227 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.173185 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 07:03:26.548599) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 07:03:26.551956) ========= 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=836cfdc75598d54cb747368e000001a9-1506002068.466600-826066333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018660 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 07:03:26.612515) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 13 secs) (at 2017-09-21 07:03:26.612845) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9caeafcec9982be90820e30bc699e851cb6af907 --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 9caeafcec9982be90820e30bc699e851cb6af907 --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=836cfdc75598d54cb747368e000001a9-1506002068.466600-826066333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-21 07:03:26,978 truncating revision to first 12 chars 2017-09-21 07:03:26,978 Setting DEBUG logging. 2017-09-21 07:03:26,978 attempt 1/10 2017-09-21 07:03:26,978 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9caeafcec998?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-21 07:03:27,537 attempt 1/10 2017-09-21 07:03:28,186 current task status: no status available at this point. state: STARTED 2017-09-21 07:03:28,186 sleeping for 11.00s (attempt 1/10) 2017-09-21 07:03:39,197 attempt 2/10 2017-09-21 07:03:39,528 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-09-21 07:03:39,702 unpacking tar archive at: mozilla-central-9caeafcec998/testing/mozharness/ program finished with exit code 0 elapsedTime=13.014786 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 13 secs) (at 2017-09-21 07:03:39.647866) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-21 07:03:39.648171) ========= script_repo_revision: 9caeafcec9982be90820e30bc699e851cb6af907 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-21 07:03:39.648531) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-21 07:03:39.648812) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-21 07:03:39.665567) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-09-21 07:03:39.668921) ========= /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=836cfdc75598d54cb747368e000001a9-1506002068.466600-826066333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:03:40 INFO - MultiFileLogger online at 20170921 07:03:40 in /builds/slave/test 07:03:40 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 07:03:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:03:40 INFO - {'append_to_log': False, 07:03:40 INFO - 'base_work_dir': '/builds/slave/test', 07:03:40 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:03:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:03:40 INFO - 'branch': 'Firefox-Non-PGO', 07:03:40 INFO - 'buildbot_json_path': 'buildprops.json', 07:03:40 INFO - 'code_coverage': False, 07:03:40 INFO - 'config_files': ('talos/linux_config.py',), 07:03:40 INFO - 'default_actions': ('clobber', 07:03:40 INFO - 'read-buildbot-config', 07:03:40 INFO - 'download-and-extract', 07:03:40 INFO - 'populate-webroot', 07:03:40 INFO - 'create-virtualenv', 07:03:40 INFO - 'install', 07:03:40 INFO - 'setup-mitmproxy', 07:03:40 INFO - 'run-tests'), 07:03:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:03:40 INFO - 'disable_ccov_upload': False, 07:03:40 INFO - 'disable_stylo': False, 07:03:40 INFO - 'download_minidump_stackwalk': True, 07:03:40 INFO - 'download_symbols': 'ondemand', 07:03:40 INFO - 'enable_stylo': False, 07:03:40 INFO - 'enable_webrender': False, 07:03:40 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 07:03:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:03:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:03:40 INFO - 'gecko_profile': False, 07:03:40 INFO - 'gecko_profile_interval': 0, 07:03:40 INFO - 'installer_path': 'installer.exe', 07:03:40 INFO - 'log_level': 'info', 07:03:40 INFO - 'log_name': 'talos', 07:03:40 INFO - 'log_to_console': True, 07:03:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:03:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:03:40 INFO - 'opt_config_files': (), 07:03:40 INFO - 'pip_index': False, 07:03:40 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 07:03:40 INFO - 'system_bits': '32', 07:03:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:03:40 INFO - 'title': 'talos-linux64-ix-028', 07:03:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:03:40 INFO - 'use_talos_json': True, 07:03:40 INFO - 'verify': 'False', 07:03:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:03:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:03:40 INFO - 'work_dir': 'build'} 07:03:40 INFO - [mozharness: 2017-09-21 14:03:40.277516Z] Running clobber step. 07:03:40 INFO - Running pre-action listener: _resource_record_pre_action 07:03:40 INFO - Running main action method: clobber 07:03:40 INFO - rmtree: /builds/slave/test/build 07:03:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:03:41 INFO - Running post-action listener: _resource_record_post_action 07:03:41 INFO - [mozharness: 2017-09-21 14:03:41.226753Z] Finished clobber step (success) 07:03:41 INFO - [mozharness: 2017-09-21 14:03:41.226850Z] Running read-buildbot-config step. 07:03:41 INFO - Running pre-action listener: _resource_record_pre_action 07:03:41 INFO - Running main action method: read_buildbot_config 07:03:41 INFO - Using buildbot properties: 07:03:41 INFO - { 07:03:41 INFO - "project": "", 07:03:41 INFO - "product": "firefox", 07:03:41 INFO - "who": "archaeopteryx@coole-files.de", 07:03:41 INFO - "installer_path": "public/build/target.tar.bz2", 07:03:41 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 07:03:41 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 07:03:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 07:03:41 INFO - "stage_platform": "linux64", 07:03:41 INFO - "basedir": "/builds/slave/test", 07:03:41 INFO - "buildnumber": 53, 07:03:41 INFO - "platform": "ubuntu64_hw", 07:03:41 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:03:41 INFO - "slavebuilddir": "test", 07:03:41 INFO - "taskId": "SXKdIm_YR5aVmoQCI0rT9g", 07:03:41 INFO - "branch": "mozilla-central", 07:03:41 INFO - "script_repo_revision": "production", 07:03:41 INFO - "revision": "9caeafcec9982be90820e30bc699e851cb6af907", 07:03:41 INFO - "slavename": "talos-linux64-ix-028", 07:03:41 INFO - "repo_path": "mozilla-central" 07:03:41 INFO - } 07:03:41 INFO - Finding installer, test and symbols from parent task. 07:03:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SXKdIm_YR5aVmoQCI0rT9g'}, attempt #1 07:03:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SXKdIm_YR5aVmoQCI0rT9g'}, attempt #1 07:03:42 INFO - Task dependencies: OR_WzdNeS6ee0KU9V4iMiw 07:03:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OR_WzdNeS6ee0KU9V4iMiw'}, attempt #1 07:03:42 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/OR_WzdNeS6ee0KU9V4iMiw/artifacts/public/build/target.tar.bz2 07:03:42 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/OR_WzdNeS6ee0KU9V4iMiw/artifacts/public/build/target.test_packages.json 07:03:42 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/OR_WzdNeS6ee0KU9V4iMiw/artifacts/public/build/target.crashreporter-symbols.zip 07:03:42 INFO - Running post-action listener: _resource_record_post_action 07:03:42 INFO - [mozharness: 2017-09-21 14:03:42.613807Z] Finished read-buildbot-config step (success) 07:03:42 INFO - [mozharness: 2017-09-21 14:03:42.614022Z] Running download-and-extract step. 07:03:42 INFO - Running pre-action listener: _resource_record_pre_action 07:03:42 INFO - Running main action method: download_and_extract 07:03:42 INFO - mkdir: /builds/slave/test/build/tests 07:03:42 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')]} 07:03:42 INFO - trying https://queue.taskcluster.net/v1/task/OR_WzdNeS6ee0KU9V4iMiw/artifacts/public/build/target.test_packages.json 07:03:42 INFO - Downloading https://queue.taskcluster.net/v1/task/OR_WzdNeS6ee0KU9V4iMiw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:03:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OR_WzdNeS6ee0KU9V4iMiw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:03:43 INFO - Downloaded 989 bytes. 07:03:43 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:03:43 INFO - Using the following test package requirements: 07:03:43 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 07:03:43 INFO - u'common': [u'target.common.tests.zip'], 07:03:43 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:03:43 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:03:43 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:03:43 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:03:43 INFO - u'mozbase': [u'target.common.tests.zip'], 07:03:43 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:03:43 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:03:43 INFO - u'web-platform': [u'target.common.tests.zip', 07:03:43 INFO - u'target.web-platform.tests.tar.gz'], 07:03:43 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:03:43 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 07:03:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OR_WzdNeS6ee0KU9V4iMiw/artifacts/public/build/target.common.tests.zip 07:03:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OR_WzdNeS6ee0KU9V4iMiw/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:03:43 INFO - Fetch https://queue.taskcluster.net/v1/task/OR_WzdNeS6ee0KU9V4iMiw/artifacts/public/build/target.common.tests.zip into memory 07:03:45 INFO - Content-Length response header: 54741119 07:03:45 INFO - Bytes received: 54741119 07:03:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OR_WzdNeS6ee0KU9V4iMiw/artifacts/public/build/target.talos.tests.zip 07:03:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OR_WzdNeS6ee0KU9V4iMiw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:03:56 INFO - Fetch https://queue.taskcluster.net/v1/task/OR_WzdNeS6ee0KU9V4iMiw/artifacts/public/build/target.talos.tests.zip into memory 07:03:56 INFO - Content-Length response header: 14509184 07:03:56 INFO - Bytes received: 14509184 07:03:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:03:57 INFO - trying https://queue.taskcluster.net/v1/task/OR_WzdNeS6ee0KU9V4iMiw/artifacts/public/build/target.tar.bz2 07:03:57 INFO - Downloading https://queue.taskcluster.net/v1/task/OR_WzdNeS6ee0KU9V4iMiw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:03:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OR_WzdNeS6ee0KU9V4iMiw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:03:59 INFO - Downloaded 61692717 bytes. 07:03:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OR_WzdNeS6ee0KU9V4iMiw/artifacts/public/build/target.tar.bz2 07:03:59 INFO - mkdir: /builds/slave/test/properties 07:03:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:03:59 INFO - Writing to file /builds/slave/test/properties/build_url 07:03:59 INFO - Contents: 07:03:59 INFO - build_url:https://queue.taskcluster.net/v1/task/OR_WzdNeS6ee0KU9V4iMiw/artifacts/public/build/target.tar.bz2 07:03:59 INFO - Running post-action listener: _resource_record_post_action 07:03:59 INFO - Running post-action listener: find_tests_for_verification 07:03:59 INFO - Running post-action listener: set_extra_try_arguments 07:03:59 INFO - [mozharness: 2017-09-21 14:03:59.054804Z] Finished download-and-extract step (success) 07:03:59 INFO - [mozharness: 2017-09-21 14:03:59.054902Z] Running populate-webroot step. 07:03:59 INFO - Running pre-action listener: _resource_record_pre_action 07:03:59 INFO - Running main action method: populate_webroot 07:03:59 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:03:59 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:03:59 INFO - 'tests': ['tresize', 07:03:59 INFO - 'tcanvasmark']}, 07:03:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:03:59 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:03:59 INFO - 'tests': ['dromaeo_css', 07:03:59 INFO - 'kraken']}, 07:03:59 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:03:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:03:59 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:03:59 INFO - 'talos_options': ['--disable-stylo'], 07:03:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:03:59 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:03:59 INFO - 'tests': ['damp', 'tps']}, 07:03:59 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:03:59 INFO - 'talos_options': ['--disable-stylo'], 07:03:59 INFO - 'tests': ['damp', 'tps']}, 07:03:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:03:59 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:03:59 INFO - 'tests': ['dromaeo_dom']}, 07:03:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 07:03:59 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:03:59 INFO - 'tests': ['basic_compositor_video', 07:03:59 INFO - 'glvideo']}, 07:03:59 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 07:03:59 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 07:03:59 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:03:59 INFO - 'talos_options': ['--disable-stylo'], 07:03:59 INFO - 'tests': ['ts_paint_webext', 07:03:59 INFO - 'tp5o_webext']}, 07:03:59 INFO - 'other-e10s': {'tests': ['a11yr', 07:03:59 INFO - 'ts_paint', 07:03:59 INFO - 'tpaint', 07:03:59 INFO - 'sessionrestore', 07:03:59 INFO - 'sessionrestore_many_windows', 07:03:59 INFO - 'sessionrestore_no_auto_restore', 07:03:59 INFO - 'tabpaint']}, 07:03:59 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:03:59 INFO - 'tests': ['a11yr', 07:03:59 INFO - 'ts_paint', 07:03:59 INFO - 'tpaint', 07:03:59 INFO - 'sessionrestore', 07:03:59 INFO - 'sessionrestore_many_windows', 07:03:59 INFO - 'sessionrestore_no_auto_restore', 07:03:59 INFO - 'tabpaint']}, 07:03:59 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 07:03:59 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 07:03:59 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:03:59 INFO - 'tests': ['perf_reftest_singletons']}, 07:03:59 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:03:59 INFO - 'tests': ['bloom_basic']}, 07:03:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:03:59 INFO - 'tsvgr_opacity', 07:03:59 INFO - 'tart', 07:03:59 INFO - 'tscrollx', 07:03:59 INFO - 'tsvg_static']}, 07:03:59 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:03:59 INFO - 'tests': ['tsvgx', 07:03:59 INFO - 'tsvgr_opacity', 07:03:59 INFO - 'tart', 07:03:59 INFO - 'tscrollx', 07:03:59 INFO - 'tsvg_static']}, 07:03:59 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:03:59 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:03:59 INFO - 'talos_options': ['--disable-stylo'], 07:03:59 INFO - 'tests': ['tp5o']}, 07:03:59 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:03:59 INFO - 'talos_options': ['--mitmproxy', 07:03:59 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:03:59 INFO - '--firstNonBlankPaint'], 07:03:59 INFO - 'tests': ['tp6_google', 07:03:59 INFO - 'tp6_youtube', 07:03:59 INFO - 'tp6_amazon', 07:03:59 INFO - 'tp6_facebook']}, 07:03:59 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:03:59 INFO - 'talos_options': ['--disable-stylo', 07:03:59 INFO - '--mitmproxy', 07:03:59 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:03:59 INFO - '--firstNonBlankPaint'], 07:03:59 INFO - 'tests': ['tp6_google', 07:03:59 INFO - 'tp6_youtube', 07:03:59 INFO - 'tp6_amazon', 07:03:59 INFO - 'tp6_facebook']}, 07:03:59 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:03:59 INFO - 'talos_options': ['--stylo-threads=1', 07:03:59 INFO - '--mitmproxy', 07:03:59 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:03:59 INFO - '--firstNonBlankPaint'], 07:03:59 INFO - 'tests': ['tp6_google', 07:03:59 INFO - 'tp6_youtube', 07:03:59 INFO - 'tp6_amazon', 07:03:59 INFO - 'tp6_facebook']}, 07:03:59 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:03:59 INFO - 'talos_options': ['--xperf_path', 07:03:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:03:59 INFO - 'tests': ['tp5n']}, 07:03:59 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:03:59 INFO - 'talos_options': ['--disable-stylo', 07:03:59 INFO - '--xperf_path', 07:03:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:03:59 INFO - 'tests': ['tp5n']}}} 07:03:59 INFO - Running post-action listener: _resource_record_post_action 07:03:59 INFO - [mozharness: 2017-09-21 14:03:59.069698Z] Finished populate-webroot step (success) 07:03:59 INFO - [mozharness: 2017-09-21 14:03:59.069787Z] Running create-virtualenv step. 07:03:59 INFO - Running pre-action listener: _resource_record_pre_action 07:03:59 INFO - Running main action method: create_virtualenv 07:03:59 INFO - Creating virtualenv /builds/slave/test/build/venv 07:03:59 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:03:59 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 07:03:59 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 07:03:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:03:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:04:00 INFO - Installing distribute.............................................................................................................................................................................................done. 07:04:00 INFO - Installing pip...............done. 07:04:00 INFO - Return code: 0 07:04:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:04:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:04:01 INFO - Reading from file tmpfile_stdout 07:04:01 INFO - Output received: 07:04:01 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 07:04:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:04: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')]} 07:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04: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')]} 07:04:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c911f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffda60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2001090>, '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 0x2001d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ffbf90>, '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': '836cfdc75598d54cb747368e000001a9-1506002068.466600-826066333', '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 07:04:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:04:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:04:01 INFO - Using env: {'DISPLAY': ':0', 07:04:01 INFO - 'HOME': '/home/cltbld', 07:04:01 INFO - 'LANG': 'en_US.UTF-8', 07:04:01 INFO - 'LANGUAGE': 'en_US:en', 07:04:01 INFO - 'LOGNAME': 'cltbld', 07:04:01 INFO - 'MAIL': '/var/mail/cltbld', 07:04:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:01 INFO - 'MOZ_NO_REMOTE': '1', 07:04:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:01 INFO - 'NO_EM_RESTART': '1', 07:04:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:01 INFO - 'PWD': '/builds/slave/test', 07:04:01 INFO - 'SHELL': '/bin/bash', 07:04:01 INFO - 'SHLVL': '1', 07:04:01 INFO - 'TERM': 'linux', 07:04:01 INFO - 'TMOUT': '86400', 07:04:01 INFO - 'USER': 'cltbld', 07:04:01 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506002068.466600-826066333', 07:04:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:01 INFO - '_': '/tools/buildbot/bin/python'} 07:04:02 INFO - Ignoring indexes: http://pypi.python.org/simple/ 07:04:02 INFO - Downloading/unpacking pip>=1.5 07:04:02 INFO - Running setup.py egg_info for package pip 07:04:02 INFO - warning: no files found matching 'pip/cacert.pem' 07:04:02 INFO - warning: no files found matching '*.html' under directory 'docs' 07:04:02 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 07:04:02 INFO - no previously-included directories found matching 'docs/_build/_sources' 07:04:02 INFO - Installing collected packages: pip 07:04:02 INFO - Found existing installation: pip 1.1 07:04:02 INFO - Uninstalling pip: 07:04:02 INFO - Successfully uninstalled pip 07:04:02 INFO - Running setup.py install for pip 07:04:02 INFO - warning: no files found matching 'pip/cacert.pem' 07:04:02 INFO - warning: no files found matching '*.html' under directory 'docs' 07:04:02 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 07:04:02 INFO - no previously-included directories found matching 'docs/_build/_sources' 07:04:02 INFO - Installing pip script to /builds/slave/test/build/venv/bin 07:04:02 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 07:04:02 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 07:04:02 INFO - Successfully installed pip 07:04:02 INFO - Cleaning up... 07:04:02 INFO - Return code: 0 07:04:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:04:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1c911f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffda60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2001090>, '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 0x2001d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ffbf90>, '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': '836cfdc75598d54cb747368e000001a9-1506002068.466600-826066333', '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 07:04:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:04:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:04:02 INFO - Using env: {'DISPLAY': ':0', 07:04:02 INFO - 'HOME': '/home/cltbld', 07:04:02 INFO - 'LANG': 'en_US.UTF-8', 07:04:02 INFO - 'LANGUAGE': 'en_US:en', 07:04:02 INFO - 'LOGNAME': 'cltbld', 07:04:02 INFO - 'MAIL': '/var/mail/cltbld', 07:04:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:02 INFO - 'MOZ_NO_REMOTE': '1', 07:04:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:02 INFO - 'NO_EM_RESTART': '1', 07:04:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:02 INFO - 'PWD': '/builds/slave/test', 07:04:02 INFO - 'SHELL': '/bin/bash', 07:04:02 INFO - 'SHLVL': '1', 07:04:02 INFO - 'TERM': 'linux', 07:04:02 INFO - 'TMOUT': '86400', 07:04:02 INFO - 'USER': 'cltbld', 07:04:02 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506002068.466600-826066333', 07:04:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:02 INFO - '_': '/tools/buildbot/bin/python'} 07:04:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:02 INFO - Downloading/unpacking psutil>=3.1.1 07:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:04:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:04:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:04:03 INFO - Installing collected packages: psutil 07:04:03 INFO - Running setup.py install for psutil 07:04:03 INFO - building 'psutil._psutil_linux' extension 07:04:03 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 07:04:05 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 07:04:05 INFO - building 'psutil._psutil_posix' extension 07:04:05 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 07:04:05 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 07:04:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:04:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:04:05 INFO - Successfully installed psutil 07:04:05 INFO - Cleaning up... 07:04:05 INFO - Return code: 0 07:04:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:04:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c911f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffda60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2001090>, '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 0x2001d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ffbf90>, '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': '836cfdc75598d54cb747368e000001a9-1506002068.466600-826066333', '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 07:04:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:04:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:04:05 INFO - Using env: {'DISPLAY': ':0', 07:04:05 INFO - 'HOME': '/home/cltbld', 07:04:05 INFO - 'LANG': 'en_US.UTF-8', 07:04:05 INFO - 'LANGUAGE': 'en_US:en', 07:04:05 INFO - 'LOGNAME': 'cltbld', 07:04:05 INFO - 'MAIL': '/var/mail/cltbld', 07:04:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:05 INFO - 'MOZ_NO_REMOTE': '1', 07:04:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:05 INFO - 'NO_EM_RESTART': '1', 07:04:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:05 INFO - 'PWD': '/builds/slave/test', 07:04:05 INFO - 'SHELL': '/bin/bash', 07:04:05 INFO - 'SHLVL': '1', 07:04:05 INFO - 'TERM': 'linux', 07:04:05 INFO - 'TMOUT': '86400', 07:04:05 INFO - 'USER': 'cltbld', 07:04:05 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506002068.466600-826066333', 07:04:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:05 INFO - '_': '/tools/buildbot/bin/python'} 07:04:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:04:05 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 07:04:05 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 07:04:05 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 07:04:05 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 07:04:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:04:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:04:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:04:07 INFO - Installing collected packages: mozsystemmonitor 07:04:07 INFO - Running setup.py install for mozsystemmonitor 07:04:07 INFO - Successfully installed mozsystemmonitor 07:04:07 INFO - Cleaning up... 07:04:07 INFO - Return code: 0 07:04:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:04:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1c911f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffda60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2001090>, '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 0x2001d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ffbf90>, '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': '836cfdc75598d54cb747368e000001a9-1506002068.466600-826066333', '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 07:04:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:04:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:04:07 INFO - Using env: {'DISPLAY': ':0', 07:04:07 INFO - 'HOME': '/home/cltbld', 07:04:07 INFO - 'LANG': 'en_US.UTF-8', 07:04:07 INFO - 'LANGUAGE': 'en_US:en', 07:04:07 INFO - 'LOGNAME': 'cltbld', 07:04:07 INFO - 'MAIL': '/var/mail/cltbld', 07:04:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:07 INFO - 'MOZ_NO_REMOTE': '1', 07:04:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:07 INFO - 'NO_EM_RESTART': '1', 07:04:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:07 INFO - 'PWD': '/builds/slave/test', 07:04:07 INFO - 'SHELL': '/bin/bash', 07:04:07 INFO - 'SHLVL': '1', 07:04:07 INFO - 'TERM': 'linux', 07:04:07 INFO - 'TMOUT': '86400', 07:04:07 INFO - 'USER': 'cltbld', 07:04:07 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506002068.466600-826066333', 07:04:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:07 INFO - '_': '/tools/buildbot/bin/python'} 07:04:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:07 INFO - Downloading/unpacking jsonschema==2.5.1 07:04:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:04:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:08 INFO - Downloading functools32-3.2.3-2.tar.gz 07:04:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:04:08 INFO - warning: no files found matching '*.txt' 07:04:08 INFO - no previously-included directories found matching 'build' 07:04:08 INFO - no previously-included directories found matching 'dist' 07:04:08 INFO - no previously-included directories found matching '.git*' 07:04:08 INFO - Installing collected packages: jsonschema, functools32 07:04:08 INFO - Running setup.py install for functools32 07:04:08 INFO - warning: no files found matching '*.txt' 07:04:08 INFO - no previously-included directories found matching 'build' 07:04:08 INFO - no previously-included directories found matching 'dist' 07:04:08 INFO - no previously-included directories found matching '.git*' 07:04:08 INFO - Successfully installed jsonschema functools32 07:04:08 INFO - Cleaning up... 07:04:08 INFO - Return code: 0 07:04:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:04:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:08 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 0x1c911f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffda60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2001090>, '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 0x2001d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ffbf90>, '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': '836cfdc75598d54cb747368e000001a9-1506002068.466600-826066333', '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 07:04:08 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 07:04:08 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 07:04:08 INFO - Using env: {'DISPLAY': ':0', 07:04:08 INFO - 'HOME': '/home/cltbld', 07:04:08 INFO - 'LANG': 'en_US.UTF-8', 07:04:08 INFO - 'LANGUAGE': 'en_US:en', 07:04:08 INFO - 'LOGNAME': 'cltbld', 07:04:08 INFO - 'MAIL': '/var/mail/cltbld', 07:04:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:08 INFO - 'MOZ_NO_REMOTE': '1', 07:04:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:08 INFO - 'NO_EM_RESTART': '1', 07:04:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:08 INFO - 'PWD': '/builds/slave/test', 07:04:08 INFO - 'SHELL': '/bin/bash', 07:04:08 INFO - 'SHLVL': '1', 07:04:08 INFO - 'TERM': 'linux', 07:04:08 INFO - 'TMOUT': '86400', 07:04:08 INFO - 'USER': 'cltbld', 07:04:08 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506002068.466600-826066333', 07:04:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:08 INFO - '_': '/tools/buildbot/bin/python'} 07:04:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:04:09 INFO - Cleaning up... 07:04:09 INFO - Return code: 0 07:04:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:04:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:09 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 0x1c911f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffda60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2001090>, '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 0x2001d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ffbf90>, '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': '836cfdc75598d54cb747368e000001a9-1506002068.466600-826066333', '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 07:04:09 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 07:04:09 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 07:04:09 INFO - Using env: {'DISPLAY': ':0', 07:04:09 INFO - 'HOME': '/home/cltbld', 07:04:09 INFO - 'LANG': 'en_US.UTF-8', 07:04:09 INFO - 'LANGUAGE': 'en_US:en', 07:04:09 INFO - 'LOGNAME': 'cltbld', 07:04:09 INFO - 'MAIL': '/var/mail/cltbld', 07:04:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:09 INFO - 'MOZ_NO_REMOTE': '1', 07:04:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:09 INFO - 'NO_EM_RESTART': '1', 07:04:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:09 INFO - 'PWD': '/builds/slave/test', 07:04:09 INFO - 'SHELL': '/bin/bash', 07:04:09 INFO - 'SHLVL': '1', 07:04:09 INFO - 'TERM': 'linux', 07:04:09 INFO - 'TMOUT': '86400', 07:04:09 INFO - 'USER': 'cltbld', 07:04:09 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506002068.466600-826066333', 07:04:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:09 INFO - '_': '/tools/buildbot/bin/python'} 07:04:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:09 INFO - Downloading/unpacking blobuploader==1.2.4 07:04:09 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 07:04:09 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 07:04:09 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 07:04:09 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 07:04:10 INFO - Downloading blobuploader-1.2.4.tar.gz 07:04:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:04:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:04:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:04:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:04:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:11 INFO - Downloading docopt-0.6.1.tar.gz 07:04:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:04:11 INFO - Installing collected packages: blobuploader, requests, docopt 07:04:11 INFO - Running setup.py install for blobuploader 07:04:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:04:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:04:11 INFO - Running setup.py install for requests 07:04:11 INFO - Running setup.py install for docopt 07:04:11 INFO - Successfully installed blobuploader requests docopt 07:04:11 INFO - Cleaning up... 07:04:11 INFO - Return code: 0 07:04:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:04:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:11 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 0x1c911f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffda60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2001090>, '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 0x2001d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ffbf90>, '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': '836cfdc75598d54cb747368e000001a9-1506002068.466600-826066333', '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 07:04:11 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 07:04:11 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 07:04:11 INFO - Using env: {'DISPLAY': ':0', 07:04:11 INFO - 'HOME': '/home/cltbld', 07:04:11 INFO - 'LANG': 'en_US.UTF-8', 07:04:11 INFO - 'LANGUAGE': 'en_US:en', 07:04:11 INFO - 'LOGNAME': 'cltbld', 07:04:11 INFO - 'MAIL': '/var/mail/cltbld', 07:04:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:11 INFO - 'MOZ_NO_REMOTE': '1', 07:04:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:11 INFO - 'NO_EM_RESTART': '1', 07:04:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:11 INFO - 'PWD': '/builds/slave/test', 07:04:11 INFO - 'SHELL': '/bin/bash', 07:04:11 INFO - 'SHLVL': '1', 07:04:11 INFO - 'TERM': 'linux', 07:04:11 INFO - 'TMOUT': '86400', 07:04:11 INFO - 'USER': 'cltbld', 07:04:11 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506002068.466600-826066333', 07:04:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:11 INFO - '_': '/tools/buildbot/bin/python'} 07:04:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:04:11 INFO - Running setup.py (path:/tmp/pip-w1ZZ3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:04:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:04:11 INFO - Running setup.py (path:/tmp/pip-Bu2qR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:04:12 INFO - Running setup.py (path:/tmp/pip-bcnXGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:04:12 INFO - Running setup.py (path:/tmp/pip-b4iUmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:04:12 INFO - Running setup.py (path:/tmp/pip-gSewbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:04:12 INFO - Running setup.py (path:/tmp/pip-MZHbpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:04:12 INFO - Running setup.py (path:/tmp/pip-wkfUWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:04:12 INFO - Running setup.py (path:/tmp/pip-ZQRW7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:04:12 INFO - Running setup.py (path:/tmp/pip-ARCtzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:04:12 INFO - Running setup.py (path:/tmp/pip-i_Wzh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:04:12 INFO - Running setup.py (path:/tmp/pip-ZIKr1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:04:12 INFO - Running setup.py (path:/tmp/pip-B1ha25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:04:12 INFO - Running setup.py (path:/tmp/pip-o6pG0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:04:12 INFO - Running setup.py (path:/tmp/pip-SbY8vI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:04:12 INFO - Running setup.py (path:/tmp/pip-HkJG2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:04:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:04:12 INFO - Running setup.py (path:/tmp/pip-uQtjSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:04:13 INFO - Running setup.py (path:/tmp/pip-8UJOnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:04:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:04:13 INFO - Running setup.py install for manifestparser 07:04:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:04:13 INFO - Running setup.py install for mozcrash 07:04:13 INFO - Running setup.py install for mozdebug 07:04:13 INFO - Running setup.py install for mozdevice 07:04:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:04:13 INFO - Running setup.py install for mozfile 07:04:13 INFO - Running setup.py install for mozhttpd 07:04:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:04:13 INFO - Running setup.py install for mozinfo 07:04:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:04:13 INFO - Running setup.py install for mozInstall 07:04:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:04:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:04:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:04:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:04:13 INFO - Running setup.py install for mozleak 07:04:13 INFO - Running setup.py install for mozlog 07:04:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:04:14 INFO - Running setup.py install for moznetwork 07:04:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:04:14 INFO - Running setup.py install for mozprocess 07:04:14 INFO - Running setup.py install for mozprofile 07:04:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:04:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:04:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:04:14 INFO - Running setup.py install for mozrunner 07:04:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:04:14 INFO - Running setup.py install for mozscreenshot 07:04:14 INFO - Running setup.py install for moztest 07:04:14 INFO - Running setup.py install for mozversion 07:04:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:04:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:04:14 INFO - Cleaning up... 07:04:14 INFO - Return code: 0 07:04:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:04:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:14 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 0x1c911f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffda60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2001090>, '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 0x2001d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ffbf90>, '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': '836cfdc75598d54cb747368e000001a9-1506002068.466600-826066333', '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 07:04:14 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 07:04:14 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 07:04:14 INFO - Using env: {'DISPLAY': ':0', 07:04:14 INFO - 'HOME': '/home/cltbld', 07:04:14 INFO - 'LANG': 'en_US.UTF-8', 07:04:14 INFO - 'LANGUAGE': 'en_US:en', 07:04:14 INFO - 'LOGNAME': 'cltbld', 07:04:14 INFO - 'MAIL': '/var/mail/cltbld', 07:04:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:14 INFO - 'MOZ_NO_REMOTE': '1', 07:04:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:14 INFO - 'NO_EM_RESTART': '1', 07:04:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:14 INFO - 'PWD': '/builds/slave/test', 07:04:14 INFO - 'SHELL': '/bin/bash', 07:04:14 INFO - 'SHLVL': '1', 07:04:14 INFO - 'TERM': 'linux', 07:04:14 INFO - 'TMOUT': '86400', 07:04:14 INFO - 'USER': 'cltbld', 07:04:14 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506002068.466600-826066333', 07:04:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:14 INFO - '_': '/tools/buildbot/bin/python'} 07:04:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:04:15 INFO - Running setup.py (path:/tmp/pip-zjJaW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:04:15 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)) 07:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:04:15 INFO - Running setup.py (path:/tmp/pip-qZkXQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:04:15 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)) 07:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:04:15 INFO - Running setup.py (path:/tmp/pip-aSgRe4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:04:15 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)) 07:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:04:15 INFO - Running setup.py (path:/tmp/pip-jxt1Ig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:04:15 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)) 07:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:04:15 INFO - Running setup.py (path:/tmp/pip-y_Nxth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:04:15 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)) 07:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:04:15 INFO - Running setup.py (path:/tmp/pip-hKv3VN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:04:15 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)) 07:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:04:15 INFO - Running setup.py (path:/tmp/pip-sPUZaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:04:15 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)) 07:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:04:15 INFO - Running setup.py (path:/tmp/pip-eTazON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:04:15 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)) 07:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:04:15 INFO - Running setup.py (path:/tmp/pip-qlntDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:04:15 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)) 07:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:04:15 INFO - Running setup.py (path:/tmp/pip-GdS7ff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:04:15 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)) 07:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:04:15 INFO - Running setup.py (path:/tmp/pip-CfFv6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:04:15 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)) 07:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:04:15 INFO - Running setup.py (path:/tmp/pip-Y3Ys7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:04:15 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)) 07:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:04:15 INFO - Running setup.py (path:/tmp/pip-iWS8z9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:04:15 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)) 07:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:04:15 INFO - Running setup.py (path:/tmp/pip-CxFxvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:04:16 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)) 07:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:04:16 INFO - Running setup.py (path:/tmp/pip-y_fPy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:04:16 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)) 07:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:04:16 INFO - Running setup.py (path:/tmp/pip-eEYdFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:04:16 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)) 07:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:04:16 INFO - Running setup.py (path:/tmp/pip-yv4XXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:04:16 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)) 07:04:16 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)) 07:04:16 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)) 07:04:16 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)) 07:04:16 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)) 07:04:16 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)) 07:04:16 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)) 07:04:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:04:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:17 INFO - Downloading blessings-1.6.tar.gz 07:04:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:04:17 INFO - Installing collected packages: blessings 07:04:17 INFO - Running setup.py install for blessings 07:04:17 INFO - Successfully installed blessings 07:04:17 INFO - Cleaning up... 07:04:17 INFO - Return code: 0 07:04:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:04:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:04:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:04:17 INFO - Reading from file tmpfile_stdout 07:04:17 INFO - Current package versions: 07:04:17 INFO - argparse == 1.2.1 07:04:17 INFO - blessings == 1.6 07:04:17 INFO - blobuploader == 1.2.4 07:04:17 INFO - docopt == 0.6.1 07:04:17 INFO - functools32 == 3.2.3-2 07:04:17 INFO - jsonschema == 2.5.1 07:04:17 INFO - manifestparser == 1.1 07:04:17 INFO - mozInstall == 1.13 07:04:17 INFO - mozcrash == 1.0 07:04:17 INFO - mozdebug == 0.1 07:04:17 INFO - mozdevice == 0.51 07:04:17 INFO - mozfile == 1.2 07:04:17 INFO - mozhttpd == 0.7 07:04:17 INFO - mozinfo == 0.10 07:04:17 INFO - mozleak == 0.1 07:04:17 INFO - mozlog == 3.5 07:04:17 INFO - moznetwork == 0.27 07:04:17 INFO - mozprocess == 0.25 07:04:17 INFO - mozprofile == 0.28 07:04:17 INFO - mozrunner == 6.13 07:04:17 INFO - mozscreenshot == 0.1 07:04:17 INFO - mozsystemmonitor == 0.3 07:04:17 INFO - moztest == 0.8 07:04:17 INFO - mozversion == 1.4 07:04:17 INFO - psutil == 3.1.1 07:04:17 INFO - requests == 1.2.3 07:04:17 INFO - wsgiref == 0.1.2 07:04:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:04:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:17 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 0x1c911f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffda60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2001090>, '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 0x2001d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ffbf90>, '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': '836cfdc75598d54cb747368e000001a9-1506002068.466600-826066333', '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 07:04:17 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 07:04:17 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 07:04:17 INFO - Using env: {'DISPLAY': ':0', 07:04:17 INFO - 'HOME': '/home/cltbld', 07:04:17 INFO - 'LANG': 'en_US.UTF-8', 07:04:17 INFO - 'LANGUAGE': 'en_US:en', 07:04:17 INFO - 'LOGNAME': 'cltbld', 07:04:17 INFO - 'MAIL': '/var/mail/cltbld', 07:04:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:17 INFO - 'MOZ_NO_REMOTE': '1', 07:04:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:17 INFO - 'NO_EM_RESTART': '1', 07:04:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:17 INFO - 'PWD': '/builds/slave/test', 07:04:17 INFO - 'SHELL': '/bin/bash', 07:04:17 INFO - 'SHLVL': '1', 07:04:17 INFO - 'TERM': 'linux', 07:04:17 INFO - 'TMOUT': '86400', 07:04:17 INFO - 'USER': 'cltbld', 07:04:17 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506002068.466600-826066333', 07:04:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:17 INFO - '_': '/tools/buildbot/bin/python'} 07:04:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:18 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)) 07:04:18 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)) 07:04:18 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)) 07:04:18 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)) 07:04:18 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)) 07:04:18 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)) 07:04:18 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)) 07:04:18 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)) 07:04:18 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)) 07:04:18 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 07:04:18 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 07:04:18 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 07:04:18 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 07:04:18 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 07:04:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 07:04:19 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)) 07:04:19 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)) 07:04:19 INFO - Installing collected packages: simplejson 07:04:19 INFO - Running setup.py install for simplejson 07:04:19 INFO - building 'simplejson._speedups' extension 07:04:19 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 07:04:20 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 07:04:20 INFO - Successfully installed simplejson 07:04:20 INFO - Cleaning up... 07:04:20 INFO - Return code: 0 07:04:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:04:20 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')]} 07:04:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:20 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')]} 07:04:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:20 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 0x1c911f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffda60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2001090>, '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 0x2001d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ffbf90>, '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': '836cfdc75598d54cb747368e000001a9-1506002068.466600-826066333', '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 07:04:20 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 07:04:20 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 07:04:20 INFO - Using env: {'DISPLAY': ':0', 07:04:20 INFO - 'HOME': '/home/cltbld', 07:04:20 INFO - 'LANG': 'en_US.UTF-8', 07:04:20 INFO - 'LANGUAGE': 'en_US:en', 07:04:20 INFO - 'LOGNAME': 'cltbld', 07:04:20 INFO - 'MAIL': '/var/mail/cltbld', 07:04:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:20 INFO - 'MOZ_NO_REMOTE': '1', 07:04:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:20 INFO - 'NO_EM_RESTART': '1', 07:04:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:20 INFO - 'PWD': '/builds/slave/test', 07:04:20 INFO - 'SHELL': '/bin/bash', 07:04:20 INFO - 'SHLVL': '1', 07:04:20 INFO - 'TERM': 'linux', 07:04:20 INFO - 'TMOUT': '86400', 07:04:20 INFO - 'USER': 'cltbld', 07:04:20 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506002068.466600-826066333', 07:04:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:20 INFO - '_': '/tools/buildbot/bin/python'} 07:04:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:04:20 INFO - Cleaning up... 07:04:20 INFO - Return code: 0 07:04:20 INFO - Running post-action listener: _resource_record_post_action 07:04:20 INFO - Running post-action listener: _start_resource_monitoring 07:04:20 INFO - Starting resource monitoring. 07:04:20 INFO - [mozharness: 2017-09-21 14:04:20.592071Z] Finished create-virtualenv step (success) 07:04:20 INFO - [mozharness: 2017-09-21 14:04:20.593078Z] Running install step. 07:04:20 INFO - Running pre-action listener: _resource_record_pre_action 07:04:20 INFO - Running main action method: install 07:04:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:04:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:04:20 INFO - Reading from file tmpfile_stdout 07:04:20 INFO - Detecting whether we're running mozinstall >=1.0... 07:04:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:04:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:04:20 INFO - Reading from file tmpfile_stdout 07:04:20 INFO - Output received: 07:04:20 INFO - Usage: mozinstall [options] installer 07:04:20 INFO - Options: 07:04:20 INFO - -h, --help show this help message and exit 07:04:20 INFO - -d DEST, --destination=DEST 07:04:20 INFO - Directory to install application into. [default: 07:04:20 INFO - "/builds/slave/test"] 07:04:20 INFO - --app=APP Application being installed. [default: firefox] 07:04:20 INFO - mkdir: /builds/slave/test/build/application 07:04:20 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'] 07:04:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:04:38 INFO - Reading from file tmpfile_stdout 07:04:38 INFO - Output received: 07:04:38 INFO - /builds/slave/test/build/application/firefox/firefox 07:04:38 INFO - Running post-action listener: _resource_record_post_action 07:04:38 INFO - [mozharness: 2017-09-21 14:04:38.711740Z] Finished install step (success) 07:04:38 INFO - [mozharness: 2017-09-21 14:04:38.711990Z] Running setup-mitmproxy step. 07:04:38 INFO - Running pre-action listener: _resource_record_pre_action 07:04:38 INFO - Running main action method: setup_mitmproxy 07:04:38 INFO - Skipping: mitmproxy is not required 07:04:38 INFO - Running post-action listener: _resource_record_post_action 07:04:38 INFO - [mozharness: 2017-09-21 14:04:38.713107Z] Finished setup-mitmproxy step (success) 07:04:38 INFO - [mozharness: 2017-09-21 14:04:38.713324Z] Running run-tests step. 07:04:38 INFO - Running pre-action listener: _resource_record_pre_action 07:04:38 INFO - Running pre-action listener: _set_gcov_prefix 07:04:38 INFO - Running main action method: run_tests 07:04:38 WARNING - Try message not found. 07:04:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:04:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:04:38 INFO - Python 2.7.3 07:04:38 INFO - Return code: 0 07:04:38 INFO - grabbing minidump binary from tooltool 07:04:38 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')]} 07:04:38 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 0x2001090>, '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 0x2001d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ffbf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:04:38 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 07:04:38 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 07:04:38 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 07:04:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:04:39 INFO - Return code: 0 07:04:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:04:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:04:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:04:39 INFO - ENV: RUST_BACKTRACE is now full 07:04:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:04:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:04:39 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/OR_WzdNeS6ee0KU9V4iMiw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 07:04:39 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/OR_WzdNeS6ee0KU9V4iMiw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-028 --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 07:04:39 INFO - Using env: {'DISPLAY': ':0', 07:04:39 INFO - 'HOME': '/home/cltbld', 07:04:39 INFO - 'LANG': 'en_US.UTF-8', 07:04:39 INFO - 'LANGUAGE': 'en_US:en', 07:04:39 INFO - 'LOGNAME': 'cltbld', 07:04:39 INFO - 'MAIL': '/var/mail/cltbld', 07:04:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:04:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:04:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:39 INFO - 'MOZ_NO_REMOTE': '1', 07:04:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:04:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:39 INFO - 'NO_EM_RESTART': '1', 07:04:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:39 INFO - 'PWD': '/builds/slave/test', 07:04:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:04:39 INFO - 'RUST_BACKTRACE': 'full', 07:04:39 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:04:39 INFO - 'SHELL': '/bin/bash', 07:04:39 INFO - 'SHLVL': '1', 07:04:39 INFO - 'TERM': 'linux', 07:04:39 INFO - 'TMOUT': '86400', 07:04:39 INFO - 'USER': 'cltbld', 07:04:39 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506002068.466600-826066333', 07:04:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:39 INFO - '_': '/tools/buildbot/bin/python'} 07:04:39 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/OR_WzdNeS6ee0KU9V4iMiw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 07:04:39 INFO - mozversion application_buildid: 20170921131427 07:04:39 INFO - mozversion application_changeset: 9caeafcec9982be90820e30bc699e851cb6af907 07:04:39 INFO - mozversion application_display_name: Nightly 07:04:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:04:39 INFO - mozversion application_name: Firefox 07:04:39 INFO - mozversion application_remotingname: firefox 07:04:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:04:39 INFO - mozversion application_vendor: Mozilla 07:04:39 INFO - mozversion application_version: 57.0a1 07:04:39 INFO - mozversion platform_buildid: 20170921131427 07:04:39 INFO - mozversion platform_changeset: 9caeafcec9982be90820e30bc699e851cb6af907 07:04:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:04:39 INFO - mozversion platform_version: 57.0a1 07:04:39 INFO - using testdate: 1506002679 07:04:39 INFO - actual date: 1506002679 07:04:39 INFO - starting webserver on 'localhost:48690' 07:04:39 INFO - SUITE-START | Running 2 tests 07:04:39 INFO - TEST-START | dromaeo_css 07:04:39 INFO - Initialising browser for dromaeo_css test... 07:04:39 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48690/getInfo.html -profile /tmp/tmpDUxcKY/profile 07:04:39 INFO - TEST-INFO | started process 3569 (/builds/slave/test/build/application/firefox/firefox http://localhost:48690/getInfo.html) 07:04:47 INFO - TEST-INFO | 3569: exit 0 07:04:48 INFO - Browser initialized. 07:04:48 INFO - Running cycle 1/1 for dromaeo_css test... 07:04:48 INFO - Using env: {'DISPLAY': ':0', 07:04:48 INFO - 'HOME': '/home/cltbld', 07:04:48 INFO - 'JSGC_DISABLE_POISONING': '1', 07:04:48 INFO - 'LANG': 'en_US.UTF-8', 07:04:48 INFO - 'LANGUAGE': 'en_US:en', 07:04:48 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 07:04:48 INFO - 'LOGNAME': 'cltbld', 07:04:48 INFO - 'MAIL': '/var/mail/cltbld', 07:04:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:04:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:04:48 INFO - 'MOZ_CRASHREPORTER': '1', 07:04:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:48 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 07:04:48 INFO - 'MOZ_NO_REMOTE': '1', 07:04:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:04:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:48 INFO - 'NO_EM_RESTART': '1', 07:04:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:48 INFO - 'PWD': '/builds/slave/test', 07:04:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:04:48 INFO - 'RUST_BACKTRACE': 'full', 07:04:48 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:04:48 INFO - 'SHELL': '/bin/bash', 07:04:48 INFO - 'SHLVL': '1', 07:04:48 INFO - 'STYLO_FORCE_DISABLED': '1', 07:04:48 INFO - 'TERM': 'linux', 07:04:48 INFO - 'TMOUT': '86400', 07:04:48 INFO - 'USER': 'cltbld', 07:04:48 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506002068.466600-826066333', 07:04:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:48 INFO - '_': '/tools/buildbot/bin/python'} 07:04:48 INFO - TEST-INFO | started process 3805 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDUxcKY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:04:48 INFO - PID 3805 | 07:04:48 INFO - PID 3805 | (/builds/slave/test/build/application/firefox/firefox:3854): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:04:48 INFO - PID 3805 | 07:04:59 INFO - PID 3805 | RSS: Main: 150630400 07:04:59 INFO - PID 3805 | 07:07:56 INFO - PID 3805 | Cycle 1(1): loaded http://localhost:48690/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48690/tests/dromaeo/cssquery-ext.html) 07:07:57 INFO - PID 3805 | RSS: Main: 154206208 07:07:57 INFO - PID 3805 | 07:10:59 INFO - PID 3805 | Cycle 1(1): loaded http://localhost:48690/tests/dromaeo/cssquery-ext.html (next: http://localhost:48690/tests/dromaeo/cssquery-jquery.html) 07:11:00 INFO - PID 3805 | RSS: Main: 154083328 07:11:00 INFO - PID 3805 | 07:14:02 INFO - PID 3805 | Cycle 1(1): loaded http://localhost:48690/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48690/tests/dromaeo/cssquery-mootools.html) 07:14:02 INFO - PID 3805 | RSS: Main: 156389376 07:14:02 INFO - PID 3805 | 07:17:04 INFO - PID 3805 | Cycle 1(1): loaded http://localhost:48690/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48690/tests/dromaeo/cssquery-prototype.html) 07:17:04 INFO - PID 3805 | RSS: Main: 156147712 07:17:04 INFO - PID 3805 | 07:20:08 INFO - PID 3805 | Cycle 1(1): loaded http://localhost:48690/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48690/tests/dromaeo/cssquery-yui.html) 07:20:08 INFO - PID 3805 | RSS: Main: 155746304 07:20:08 INFO - PID 3805 | 07:23:10 INFO - PID 3805 | Cycle 1(1): loaded http://localhost:48690/tests/dromaeo/cssquery-yui.html (next: http://localhost:48690/tests/dromaeo/cssquery-dojo.html) 07:23:10 INFO - PID 3805 | RSS: Main: 156733440 07:23:10 INFO - PID 3805 | 07:23:10 INFO - PID 3805 | __start_tp_report 07:23:10 INFO - PID 3805 | _x_x_mozilla_page_load 07:23:10 INFO - PID 3805 | _x_x_mozilla_page_load_details 07:23:10 INFO - PID 3805 | |i|pagename|runs| 07:23:10 INFO - PID 3805 | |0;dojo.html;3125.359301343225;3149.622045354558;3157.494800831866;3160.715535601795;3170.2074481379664;6137.38626137386;6299.496040316775;6330.841728956772;6356.110144579762;6365.108884756132;6283.183186185801;6310.810675679737;6318.873622527547;6320.652364119972;6477.157969463975;5790.507806836424;5859.53123750099;5869.148973398855;5869.589128760988;5912.763489460416;5479.0959491683825;5643.435656434344;5694.402087780785;5813.331466881299;5841.912371314413;5771.163181338703;5778.451047150514;5848.912266316009;5858.326292476378;5865.296164460271;5656.123300888369;5735.11105778605;5780.826575202751;5834.854128646775;5843.941560584382;5766.654000759968;5808.738606762706;5832.650040997553;5839.591228613998;5845.503132233765;6256.749730010794;6261.87476250477;6262.060690896356;6310.053491976194;6322.146510221107;6561.2782593914635;6706.899396509057;6760.391564759196;6764.154480689914;6779.694913728894;6704.765333213363;6756.054152418666;6807.455403567703;6833.3166683331765;6846.110005699227;6341.682915854235;6357.586756860789;6363.459105976044;6365.077063825765;6368.458681012119;6929.341712537301;6945.826354341182;6948.5483443576;6954.478414118961;7020.824479387954;6478.967605161944;6612.404883560503;6714.429273511806;6765.898511522331;6781.6609169541325;6727.798166055026;6794.694238759268;6804.693788779517;6810.523263371517;6818.4886133540185;6746.966265168643;6760.391564759097;6835.350641689031;6836.248012718597;6840.384365407137;6508.837279067967;6611;6619.536632435684;6630.270670226271;6786.981952707133;5233.136532472099;5242.5281724644965;5249.160134378558;5268.762905669178;5299.5760339172775;4627.421572303462;4631.675782695179;4654.045920586272;4660.813567457331;4706.270528068155;5755.971220143956;5785.595008349375;5793.362730099686;5836.037053886146;5868.735906884201;6619.569727967763;6735;6738.7304507819135;6773.322667733286;6851.3491218334175;5795.072788353843;5858.56060795442;5860.765569377262;5865.912011319833;5867.941320586825;5729.28383952006;5849.502792262705;5891.116332550152;5894.911576326359;5898.705064746746;6561.376669216417;6580.506462015368;6648.700808463631;6651.401373876374;6670.366315200048;6581.276059633341;6641.568298060611;6735.393814556714;6811.523193376416;6882.105326307548;6533.118029066015;6533.281339052605;6542.83642908912;6548;6550.770723024862;6627.900581491378;6636.203655561363;6725.7893579156225;6739.359760822714;6741.932580674131;6794.864102717819;6817.761378351734;6819.727210911508;6883.3116688330765;6920.446364290945;6530.053142294246;6558.245801732862;6637.966810166112;6638.137042184485;6667.36660017317;6572.80281591553;6580.7038683260325;6604.108445359815;6612.8346791330605;6616.338366163538;6451.580647257913;6458.483321334188;6494.09082728409;6551.377619126175;6559.573627714183;6510.73957041713;6533.379328963741;6611.041398997215;6618.6690665467495;6669.433098186514;6277.874442511215;6374;6379.075034119934;6385.233771947396;6468.676566171766 07:23:10 INFO - PID 3805 | |1;ext.html;869.6347534035705;876.618670878168;878.0999475537574;882.5940067568918;885.8316919785236;40512.39231411528;40985.38521922174;41628;41692.58307416921;41796.79101604492;38034.23931521368;38125.428118578246;38208.426873596916;38238.61761382385;38344.23311533768;7099.077119974409;7220.602866842321;7222.783316500487;7223.458240631948;7225.710971561131;7122.715091396338;7185.964070179642;7212.783616491513;7220.386267167297;7224.783256502314;7789.298963093321;7951.244631759973;7957.124716281204;7963.283304502594;7967.681292748312;7901.565413902233;7959.880601790977;7967.243111904418;7972.282494575487;7972.521648701097;7681.57751323677;7833.960830195812;7897.5656338901335;7904.249096335839;7920.64357103926;37246.25507489862;37317.253654926746;37531.81234093839;37556.62443375558;37576.81211593925;3465.6534346565395;3497.842597083137;3506.36885360635;3515.894523164284;3523.982380088083;31446.842765786023;31504.212394690087;31556.36887262265;31580.52629210564;31683.841580792177;5130.97434512825;5175.948240517584;5180;5210.114280572312;5282.947170528322;186964;187452;187570;187607;188098;47777;47813.52186478091;48005.75997120062;48067.759661202166;48091.519084809406;49880.50119498831;50096.74951625219;50171.74914125406;50255.74872125689;50359.74820125876;15263.92368038175;15394.153321567197;15438.45965391206;15511.844881551266;15580.532584022498;12660.683482913;12675.556355527513;12740.80888786669;12777.361131943366;12789.488420463264;14133.787993179905;14318.427262909367;14318.85681143196;14397.92801036009;14495.565133046026;5624.29696287964;5792.913106303409;5832.679202643895;5843.357230704619;5856.941430585724;982.4449186209769;1002.2032484175098;1007.6573964851839;1013.0780989299702;1028.0490546244694;22458;22571;22760.31719048431;22808.885955570448;22857.31428057161;1113.6659002299277;1114.4594871487323;1115.8158903780786;1128.4019469681082;1133.4729350851728;12009.579664711693;12160.601530824068;12208.145429820004;12228.571999979958;12285.262884226975;227911;228595;228674;229135;229893;44350;45399;50364.244536331986;50779.74610126926;50949.490505095215;1459.314122362488;1480.3042569992087;1495;1495.1253516692857;1501.6996600679909;26904.192874213804;27138;27566.862165689043;27688.58467123035;27708;36652.45021324629;36882.63117368899;36969.6303036977;36989.815050924575;37014.25971480609;188975;190578;190730;191017;191437;31940;33005.33989320248;33230;33238.833805830815;33270;42104;42226.577734222265;42471;42614.36078458764;42656.57343426526;31503.84248078745;31547.36905261836;31664.366712666077;31666.208344791565;31959;31033.069007929796;31085.68914310828;31165.376692465572;31334.373312533167;31433.8428307857;35692.643073568936;35880.4617930726;35889.28221435609;35962.82018589995;36042.639573604974;30720.23199419943;30886.22784430407;31039.844800775852;31331.060068197992;31502;22171.55656886821;22490.212842551085;22592.435189120402;22726.659100113182;22731.772682273626 07:23:10 INFO - PID 3805 | |2;jquery.html;582.3797655496895;587.3421767620264;592.7777083593654;596.7016491754123;600.6006006006005;21648;22785.658215126787;22846.200382986597;22851.200207992722;22874.1994030209;23015.76984230157;24056;24217.636735448938;24380.878095609496;24411.00880804453;6407.006913928349;6427.196600424947;6440.710168042449;6443.420092191702;6454.322296158906;6173.814785556418;6376.649284289362;6403.199600049994;6438.452731517827;6474.5791523550815;6370.84072898179;6413.615183089007;6417.486601071903;6419.45434638054;6422.678866056702;6241.906371404432;6398.072279519467;6419;6426.421622054014;6536.084948107269;6059.697015149269;6065.757369705207;6073.180120683695;6081.665508397036;6092.055731361646;28601;29064.564031539543;29067.70932290671;29090.41819163605;29130.563041554393;2036.378904434147;2060.6599911014664;2079.178724403852;2080.5214800595795;2083;18986.14562344684;19390.90304548482;19874.403767886986;19916.10377533;19992.700109498368;2442.242904699549;2477.2444404456633;2518.609615509599;2529.0768869362732;2531.696196456437;118329.40835295855;123354.38322808419;135699;145484.27257863642;145534.27232863873;14433.293543775733;14459.349329280207;14850.480233192002;15106.942514024133;15282.541523754306;22911.19810806647;23104.306870793567;23117.653235201484;23121.768782311963;23145.537089258458;10129.848052279222;10189.439580823126;10228.795424091477;10234.59061637541;10277.588896444207;9356.625734970661;9375.624975000923;9428.905710942803;9503.144716975366;9503.619855205714;9119.424604165599;9131.269498440242;9414.246860251164;9446;9536.332456727963;2757.214193954713;2800.80394372392;2862.370278538718;2899.739023487854;2951.704829517031;950.6577632052456;956.8615736937772;961.8893827209821;967.4195482710318;978.4471773448122;18398.81601183998;18522.444326670222;18569.5357616058;18965.90517047406;19029.238830446902;997.9272282296561;1001.4683556905063;1008.1732978957185;1011.6206422591529;1022.5960745505483;10437.321574097812;10445.425501597485;10454;10652.360858348524;10751.19366047534;455225;463025;480225;481455;485239;112252;115416;115587.42206289082;116836.41581792037;117502.412487937;1031.664708969588;1071.5927947379946;1135.3925649777495;1155.3876445483907;1183.3964678014274;19488.317908873123;19504.414867553995;19580.510487237934;19738;19992.400227993185;56292.718536407054;56460;58914.11628825485;58943.70528147332;59180;71222.64388678024;71228.28771712424;71398;72484.63757681177;73136.63431682807;13949.3722782473;14190.503332383318;14270.500532481314;14273.286335683382;14308.49920252786;21864.78135218691;21892.89053554722;21908.12367505282;22027.66958495592;22216.444588885406;16891.070991095607;17109.401170958958;17727;17858.107094645475;17901.820981790537;15551.766723499382;15553.377864885279;16030.519084427486;16431.83568164303;16657.416990405276;17734.024628645548;17771.911140444216;17794.822051779316;18086.90956545209;18290.451286461426;13855.307234638027;13969.161850289016;14031.859681403464;14077.718445631235;14200.50298239598;16225.458581434745;16285.430009949594;16439.342426302814;16451.42420015294;16601 07:23:10 INFO - PID 3805 | |3;mootools.html;1329.3552626975916;1421.0478979084012;1439.0574173916089;1449.188454465499;1453.1208618785633;15032.849671503296;15635.687286254282;15721.84278157221;15757.369705211806;15761.763573546377;15507.612309692264;15521.844781552181;15586.064836109841;15641.374345026214;15665;2777.777777777783;2826.8303901765858;2847.615571897788;2860.284928767808;2861.6995215502384;2788.10780550224;2819.7885158613085;2823.5058864698594;2834.702356252584;2838.9858050709718;2733.2346942856034;2846.131929761422;2846.245744877609;2847.330877243846;2847.900323488678;2812.6062351270734;2852.3297025199063;2876.3815779607276;2881.84149871758;2884;2758.255271076798;2860.356419805548;2878.568214767781;2880.8127471714483;2883.956740648892;15242.618934526725;15256.847431525654;15380;15414.383424663;15425.305861236271;7961.681532738684;8167.183281671785;8212.219839115274;8222.671093156267;8239.340852731768;5146.122070802597;5278.841634750964;5363.704996225206;5404.91892621611;5417.783288668448;1972.1815446589792;2014.798520147988;2025.382258411184;2072.243631074662;2075.7094006839056;26915.73084269152;27136.45727085467;27152.86423567889;27188.45623087547;27282.45435091307;6988.126484189476;7567.205443428361;7594.81012974669;7851.9214807851195;7891.802704932423;17270.13649317529;17571.648567028587;17612.823871761117;17619.295228190986;17633.911830441022;8126;8203.261706446448;8217.58912054395;8275.83448331042;8284.50292982423;7452.217517160729;7546.773596792105;7565.243475652391;7720.729774457867;7720.7683769487;5424.349078110652;5498.120300751861;5549.361823390362;5572.219889215513;5595.132754423071;1555.8288588255282;1571.4028669105667;1574.0162398500936;1582.1614544291544;1596.2497626115708;880.3309484791605;901.3370331737933;907.2197909797569;912.493566070837;918.0635751533398;7222.313880181375;7358.889616655754;7436.293552112541;8693.608787604573;8710.12898710124;687.8933765266391;699.2832346844424;699.9720011199495;704.0671110778239;706.261956255714;4550.658700597469;4603.332516785047;4620.19146649335;4631.930521042187;4638.373819534319;21777.34667959964;22376.32871013872;22493.4376640582;22590.322290331318;22628.773712262668;20532;21174.153033878472;21451.46371340729;21566.353009409744;21713.999999999683;10565.260431769857;10709.46452677363;10713.892861071445;10719.196060295353;10752.784944301071;7912.32745216663;8356.065328512654;8477.15228477172;8508;8573.22840944293;18681.81318186801;19246.518837029187;19597.804021959597;19625.70561441608;19767.308144214883;19515.316963906196;19725.901370493055;19760.90119549393;19819.801801982372;19887.60224795467;10885.401302928414;11250.437478125898;11263.324200547993;11263.718407039889;11273.7745245093;14052.297385130498;14077.366518506487;14110;14180.787288190479;14186.858131418554;10924.453777311262;11137.331760094421;11339.319640821577;11431.428428578703;11491.425428728697;10993.450327483433;11026.338419694523;11100.666979990614;11187.384693841917;11279.492422841156;9965.950170249102;10132.696019119438;10133.442660653734;10139.290249682452;10141.746456338651;6536.934630653633;6555.3772391622715;6584.374484423972;6594.70323835419;6699.19609646826;6910.067140935909;6936.375726184668;6948.096747422803;7025.613591252326;7097.325754053357 07:23:10 INFO - PID 3805 | |4;prototype.html;513.9897202055957;514.2106865960749;532.438277617114;542.0405881589589;544.3196004993757;6130.44825965663;6199.287081985573;6246.4077407875675;6291.15069465622;6323.399277068677;6148.3851614838495;6152.230971128609;6227.43953044226;6251.781187658433;6306.558540902139;5206.401263854667;5224.869378265555;5230.320058392404;5263.394709608387;5281.521174071247;4918.409790825106;5075.695458272497;5100.821471248507;5207.140821764423;5256.684598924076;4996.875078123057;5045.722485263309;5050.838307189349;5090.287359769617;5093.719845408501;5033.590594633509;5073.822416215433;5086.79652813887;5092.9236061459105;5137.51193636604;4541.182587134314;4546.386237857913;4567.634589232854;4573.954260457419;4580;6204.720787564525;6217.87564248717;6235.9376406235815;6252.906206406908;6304.1804565406665;5785.40901252159;5792.507636850873;5808.82573522795;5828.863371642531;5837.6497410155525;6491.67541622917;6515.543911926167;6515.93484065158;6590.505712071614;6616.966915165442;4886.780094895738;4917.459079501252;4942.739601401619;4965.354503914504;4972.8508144755715;6946.9652651736415;6953.165620125566;6963.8607227855155;6983.790486285368;7022.859542809167;5032.899342013139;5064.5819170632285;5067.847964561069;5069.898602028013;5107.106256405114;5087.26234695967;5151.91809719963;5173.430922598511;5176.870578235575;5191.351081114861;5801.3038435388025;5808.3901190375245;5823.650580965155;5832.62087964281;5834.5624078194305;6340.50998015466;6595.208574971034;6612.801615951433;6692.297308782605;6756.966215168893;1655.7185278502684;1699.4137022727139;1743.3898135652673;1748.7726595542752;1783;1222.6515443098851;1224.2776761710634;1235.3020543392954;1242.8073648584484;1246.8005119180887;5504.174373843955;5529.419410961871;5635.69003704792;5642.548596112301;5664.49019588239;6675.232348279913;6717.899231511531;6767.458603311723;6776.966115169491;6864.730024945401;5721.170430287668;5724.137931034483;5745.655260684289;5752.194692743019;5766.798162064308;3491.022513696169;3530.5233793437556;3572.214112895159;3604.13500759821;3604.2431089471506;6410.583312084699;6464.22429308486;6523.902141467882;6541.443977261891;6590.2421221560135;6840.776747557064;6845.315468453115;6890.2420733719255;6925.445964322842;6939.201991771011;6406.743730250738;6409.615423074537;6488.156539649815;6520.380563846427;6526.967365163238;6492.48060155177;6568.277489476058;6610.305917878553;6642.535022548375;6667.899981500184;6541.6402097885075;6611.528972261314;6619.470442364503;6624.542600627854;6713.496487763339;6257.217847769029;6353.491720662429;6413.743450261937;6457.903131453126;6464.612123272619;4956.3804524434445;4960.379952505937;4967.652264341606;5002.599792016703;5009.572271902491;6349.841253968503;6652.438811057681;6754.324567543206;6754.898676519758;6799.218089919723;6341.365863413622;6432.517561182836;6447.806565803034;6468.676566171766;6477;6353.777617783356;6427.485801135991;6429.292777794345;6498.740050397932;6541.313162117909;6148.110388117578;6360.4911607072245;6388.329225431448;6488.805335839932;6564.770233041821;6477.1579694639395;6509.479241660751;6516.641584712696;6574.901376479261;6638.302978187221;6335.556511044183;6393;6398.48812095022;6403.391677790602;6419.165508483868 07:23:10 INFO - PID 3805 | |5;yui.html;897.7755561109722;900.0369604523163;911.1025639744851;912.8219997100559;923.875276837627;20022.499437514052;20270.98645067746;20296.69554956673;20318.59362812743;20380.388588342335;18476.907615461903;18503.444896653124;18888.811111888877;18955.14701838417;19052.523686907833;953.8473844184932;978.1685567267837;982.6069572171117;983.7098056073439;986.4623780039859;988.9752756181117;989.1246247071358;989.7773001074737;989.806987637411;990.9900900991006;985.2265971212599;1017.4505766885873;1024.9846252306222;1027.547878933267;1035.9223058270659;1009.6617633092849;1018.4398580780615;1018.4602160854722;1018.5416562546884;1019.0573719309609;720.5748608321115;738.7303634173542;742.1502379775181;752.3943225703307;752.5860776572863;20617.793822061736;20690.275840345515;20726.274580389763;20772.480687982923;20775.58448831015;19453.221871125137;19460.902695486573;19585.510362240915;20537.48656283605;20796.16815327385;16671.583210419714;16977.915110424492;17239.31042758288;17255.22351494186;17402;3804.9809750951067;3826.081740382316;3839.17457746583;3845.9230815383535;3846.1730727893637;105845.47077264641;127939;129468;131760.34119829437;132835;17757.378491752985;17774;17931.193096310697;18149.455516334532;18165.636687266444;31077;31657.366852662817;31683.542917450886;31782.84108579442;31847.52228716571;9146.176844084064;9399.436033837992;9456.716298511055;9475.478848663251;9499.572519236652;4432.623227025674;4458.35353873693;4501.504834468205;4504.099180163915;4508.504064552896;5528.06022976095;5614.85962850932;5621.15682647598;5628.465295796893;5663.801766938137;1046.4453839465095;1078.1536493852445;1084.4957094950885;1087.1846115413439;1091.410638255349;577.5091172503422;590.3004939147124;609.6403122157948;613.7268915332724;619.0559396919733;11973.640790776291;12157.452914618863;12413.503459861504;13077.346132693518;13344.132631378929;689.9827504312433;690.8756423843656;692.003514938487;698.552926127279;702.3538344722867;5376.838694839161;5386.782339889827;5415.431379705153;5444.40111587725;5486.451354864562;123242;124679;125287;125384;129505;104992.47503762432;106228.46885765676;106877;110531.44734276438;112016.43991779989;92153.5392323034;92685.07314927033;94558;95009;96382;10101.646442374482;10258.384496930208;10281.537330819981;10455.634052808115;10552;43000.56999429966;44454;44532.10935781331;45010;45141.32288015748;58245.12632310434;58341.12488312764;58406.4159358401;58485.415145848;58929.11606325994;15566.455174068853;15644.452444164399;15746.606334841721;15755.369785208462;15909.284082216096;15910.443134490237;16044.117573533102;16187.67624647477;16364.2636081379;16369.590760230612;14626.634334141732;14886;15053.247337632856;15162.469313574413;15179.544613661608;15529;15752.369905203663;15767.211639418212;15891.682166356377;15907.28417221251;15404.691906162037;15441.768373474182;15516.22418879074;15583.298751556435;15651.608709782347;11816.350100744541;11947.581834635746;11960.401979901144;11967.341796201292;12208.389580521116;11992;12137.817932731192;12208.75582488363;12300;12305.815412768636 07:23:10 INFO - PID 3805 | __end_tp_report 07:23:10 INFO - PID 3805 | __start_cc_report 07:23:10 INFO - PID 3805 | _x_x_mozilla_cycle_collect,290 07:23:10 INFO - PID 3805 | __end_cc_report 07:23:10 INFO - PID 3805 | __startTimestamp1506003790741__endTimestamp 07:23:10 INFO - PID 3805 | 07:23:10 INFO - PID 3805 | ------- Summary: start ------- 07:23:10 INFO - PID 3805 | Number of tests: 6 07:23:10 INFO - PID 3805 | 07:23:10 INFO - PID 3805 | [#0] dojo.html Cycles:165 Average:6213.34 Median:6478.97 stddev:749.22 (11.6%) stddev-sans-first:711.28 07:23:10 INFO - PID 3805 | Values: 3125.4 3149.6 3157.5 3160.7 3170.2 6137.4 6299.5 6330.8 6356.1 6365.1 6283.2 6310.8 6318.9 6320.7 6477.2 5790.5 5859.5 5869.1 5869.6 5912.8 5479.1 5643.4 5694.4 5813.3 5841.9 5771.2 5778.5 5848.9 5858.3 5865.3 5656.1 5735.1 5780.8 5834.9 5843.9 5766.7 5808.7 5832.7 5839.6 5845.5 6256.7 6261.9 6262.1 6310.1 6322.1 6561.3 6706.9 6760.4 6764.2 6779.7 6704.8 6756.1 6807.5 6833.3 6846.1 6341.7 6357.6 6363.5 6365.1 6368.5 6929.3 6945.8 6948.5 6954.5 7020.8 6479.0 6612.4 6714.4 6765.9 6781.7 6727.8 6794.7 6804.7 6810.5 6818.5 6747.0 6760.4 6835.4 6836.2 6840.4 6508.8 6611.0 6619.5 6630.3 6787.0 5233.1 5242.5 5249.2 5268.8 5299.6 4627.4 4631.7 4654.0 4660.8 4706.3 5756.0 5785.6 5793.4 5836.0 5868.7 6619.6 6735.0 6738.7 6773.3 6851.3 5795.1 5858.6 5860.8 5865.9 5867.9 5729.3 5849.5 5891.1 5894.9 5898.7 6561.4 6580.5 6648.7 6651.4 6670.4 6581.3 6641.6 6735.4 6811.5 6882.1 6533.1 6533.3 6542.8 6548.0 6550.8 6627.9 6636.2 6725.8 6739.4 6741.9 6794.9 6817.8 6819.7 6883.3 6920.4 6530.1 6558.2 6638.0 6638.1 6667.4 6572.8 6580.7 6604.1 6612.8 6616.3 6451.6 6458.5 6494.1 6551.4 6559.6 6510.7 6533.4 6611.0 6618.7 6669.4 6277.9 6374.0 6379.1 6385.2 6468.7 07:23:10 INFO - PID 3805 | 07:23:10 INFO - PID 3805 | [#1] ext.html Cycles:180 Average:36901.31 Median:3502.11 stddev:52568.03 (1501.0%) stddev-sans-first:52645.88 07:23:10 INFO - PID 3805 | Values: 869.6 876.6 878.1 882.6 885.8 40512.4 40985.4 41628.0 41692.6 41796.8 38034.2 38125.4 38208.4 38238.6 38344.2 7099.1 7220.6 7222.8 7223.5 7225.7 7122.7 7186.0 7212.8 7220.4 7224.8 7789.3 7951.2 7957.1 7963.3 7967.7 7901.6 7959.9 7967.2 7972.3 7972.5 7681.6 7834.0 7897.6 7904.2 7920.6 37246.3 37317.3 37531.8 37556.6 37576.8 3465.7 3497.8 3506.4 3515.9 3524.0 31446.8 31504.2 31556.4 31580.5 31683.8 5131.0 5175.9 5180.0 5210.1 5282.9 186964.0 187452.0 187570.0 187607.0 188098.0 47777.0 47813.5 48005.8 48067.8 48091.5 49880.5 50096.7 50171.7 50255.7 50359.7 15263.9 15394.2 15438.5 15511.8 15580.5 12660.7 12675.6 12740.8 12777.4 12789.5 14133.8 14318.4 14318.9 14397.9 14495.6 5624.3 5792.9 5832.7 5843.4 5856.9 982.4 1002.2 1007.7 1013.1 1028.0 22458.0 22571.0 22760.3 22808.9 22857.3 1113.7 1114.5 1115.8 1128.4 1133.5 12009.6 12160.6 12208.1 12228.6 12285.3 227911.0 228595.0 228674.0 229135.0 229893.0 44350.0 45399.0 50364.2 50779.7 50949.5 1459.3 1480.3 1495.0 1495.1 1501.7 26904.2 27138.0 27566.9 27688.6 27708.0 36652.5 36882.6 36969.6 36989.8 37014.3 188975.0 190578.0 190730.0 191017.0 191437.0 31940.0 33005.3 33230.0 33238.8 33270.0 42104.0 42226.6 42471.0 42614.4 42656.6 31503.8 31547.4 31664.4 31666.2 31959.0 31033.1 31085.7 31165.4 31334.4 31433.8 35692.6 35880.5 35889.3 35962.8 36042.6 30720.2 30886.2 31039.8 31331.1 31502.0 22171.6 22490.2 22592.4 22726.7 22731.8 07:23:10 INFO - PID 3805 | 07:23:10 INFO - PID 3805 | [#2] jquery.html Cycles:180 Average:33999.87 Median:22815.93 stddev:79911.09 (350.2%) stddev-sans-first:80095.87 07:23:10 INFO - PID 3805 | Values: 582.4 587.3 592.8 596.7 600.6 21648.0 22785.7 22846.2 22851.2 22874.2 23015.8 24056.0 24217.6 24380.9 24411.0 6407.0 6427.2 6440.7 6443.4 6454.3 6173.8 6376.6 6403.2 6438.5 6474.6 6370.8 6413.6 6417.5 6419.5 6422.7 6241.9 6398.1 6419.0 6426.4 6536.1 6059.7 6065.8 6073.2 6081.7 6092.1 28601.0 29064.6 29067.7 29090.4 29130.6 2036.4 2060.7 2079.2 2080.5 2083.0 18986.1 19390.9 19874.4 19916.1 19992.7 2442.2 2477.2 2518.6 2529.1 2531.7 118329.4 123354.4 135699.0 145484.3 145534.3 14433.3 14459.3 14850.5 15106.9 15282.5 22911.2 23104.3 23117.7 23121.8 23145.5 10129.8 10189.4 10228.8 10234.6 10277.6 9356.6 9375.6 9428.9 9503.1 9503.6 9119.4 9131.3 9414.2 9446.0 9536.3 2757.2 2800.8 2862.4 2899.7 2951.7 950.7 956.9 961.9 967.4 978.4 18398.8 18522.4 18569.5 18965.9 19029.2 997.9 1001.5 1008.2 1011.6 1022.6 10437.3 10445.4 10454.0 10652.4 10751.2 455225.0 463025.0 480225.0 481455.0 485239.0 112252.0 115416.0 115587.4 116836.4 117502.4 1031.7 1071.6 1135.4 1155.4 1183.4 19488.3 19504.4 19580.5 19738.0 19992.4 56292.7 56460.0 58914.1 58943.7 59180.0 71222.6 71228.3 71398.0 72484.6 73136.6 13949.4 14190.5 14270.5 14273.3 14308.5 21864.8 21892.9 21908.1 22027.7 22216.4 16891.1 17109.4 17727.0 17858.1 17901.8 15551.8 15553.4 16030.5 16431.8 16657.4 17734.0 17771.9 17794.8 18086.9 18290.5 13855.3 13969.2 14031.9 14077.7 14200.5 16225.5 16285.4 16439.3 16451.4 16601.0 07:23:10 INFO - PID 3805 | 07:23:10 INFO - PID 3805 | [#3] mootools.html Cycles:180 Average:9448.08 Median:2768.02 stddev:6825.14 (246.6%) stddev-sans-first:6817.02 07:23:10 INFO - PID 3805 | Values: 1329.4 1421.0 1439.1 1449.2 1453.1 15032.8 15635.7 15721.8 15757.4 15761.8 15507.6 15521.8 15586.1 15641.4 15665.0 2777.8 2826.8 2847.6 2860.3 2861.7 2788.1 2819.8 2823.5 2834.7 2839.0 2733.2 2846.1 2846.2 2847.3 2847.9 2812.6 2852.3 2876.4 2881.8 2884.0 2758.3 2860.4 2878.6 2880.8 2884.0 15242.6 15256.8 15380.0 15414.4 15425.3 7961.7 8167.2 8212.2 8222.7 8239.3 5146.1 5278.8 5363.7 5404.9 5417.8 1972.2 2014.8 2025.4 2072.2 2075.7 26915.7 27136.5 27152.9 27188.5 27282.5 6988.1 7567.2 7594.8 7851.9 7891.8 17270.1 17571.6 17612.8 17619.3 17633.9 8126.0 8203.3 8217.6 8275.8 8284.5 7452.2 7546.8 7565.2 7720.7 7720.8 5424.3 5498.1 5549.4 5572.2 5595.1 1555.8 1571.4 1574.0 1582.2 1596.2 880.3 901.3 907.2 912.5 918.1 7222.3 7358.9 7436.3 8693.6 8710.1 687.9 699.3 700.0 704.1 706.3 4550.7 4603.3 4620.2 4631.9 4638.4 21777.3 22376.3 22493.4 22590.3 22628.8 20532.0 21174.2 21451.5 21566.4 21714.0 10565.3 10709.5 10713.9 10719.2 10752.8 7912.3 8356.1 8477.2 8508.0 8573.2 18681.8 19246.5 19597.8 19625.7 19767.3 19515.3 19725.9 19760.9 19819.8 19887.6 10885.4 11250.4 11263.3 11263.7 11273.8 14052.3 14077.4 14110.0 14180.8 14186.9 10924.5 11137.3 11339.3 11431.4 11491.4 10993.5 11026.3 11100.7 11187.4 11279.5 9966.0 10132.7 10133.4 10139.3 10141.7 6536.9 6555.4 6584.4 6594.7 6699.2 6910.1 6936.4 6948.1 7025.6 7097.3 07:23:10 INFO - PID 3805 | 07:23:10 INFO - PID 3805 | [#4] prototype.html Cycles:180 Average:5531.52 Median:6211.30 stddev:1534.06 (24.7%) stddev-sans-first:1491.43 07:23:10 INFO - PID 3805 | Values: 514.0 514.2 532.4 542.0 544.3 6130.4 6199.3 6246.4 6291.2 6323.4 6148.4 6152.2 6227.4 6251.8 6306.6 5206.4 5224.9 5230.3 5263.4 5281.5 4918.4 5075.7 5100.8 5207.1 5256.7 4996.9 5045.7 5050.8 5090.3 5093.7 5033.6 5073.8 5086.8 5092.9 5137.5 4541.2 4546.4 4567.6 4574.0 4580.0 6204.7 6217.9 6235.9 6252.9 6304.2 5785.4 5792.5 5808.8 5828.9 5837.6 6491.7 6515.5 6515.9 6590.5 6617.0 4886.8 4917.5 4942.7 4965.4 4972.9 6947.0 6953.2 6963.9 6983.8 7022.9 5032.9 5064.6 5067.8 5069.9 5107.1 5087.3 5151.9 5173.4 5176.9 5191.4 5801.3 5808.4 5823.7 5832.6 5834.6 6340.5 6595.2 6612.8 6692.3 6757.0 1655.7 1699.4 1743.4 1748.8 1783.0 1222.7 1224.3 1235.3 1242.8 1246.8 5504.2 5529.4 5635.7 5642.5 5664.5 6675.2 6717.9 6767.5 6777.0 6864.7 5721.2 5724.1 5745.7 5752.2 5766.8 3491.0 3530.5 3572.2 3604.1 3604.2 6410.6 6464.2 6523.9 6541.4 6590.2 6840.8 6845.3 6890.2 6925.4 6939.2 6406.7 6409.6 6488.2 6520.4 6527.0 6492.5 6568.3 6610.3 6642.5 6667.9 6541.6 6611.5 6619.5 6624.5 6713.5 6257.2 6353.5 6413.7 6457.9 6464.6 4956.4 4960.4 4967.7 5002.6 5009.6 6349.8 6652.4 6754.3 6754.9 6799.2 6341.4 6432.5 6447.8 6468.7 6477.0 6353.8 6427.5 6429.3 6498.7 6541.3 6148.1 6360.5 6388.3 6488.8 6564.8 6477.2 6509.5 6516.6 6574.9 6638.3 6335.6 6393.0 6398.5 6403.4 6419.2 07:23:10 INFO - PID 3805 | 07:23:10 INFO - PID 3805 | [#5] yui.html Cycles:180 Average:24022.40 Median:19523.21 stddev:34258.75 (175.5%) stddev-sans-first:34310.86 07:23:10 INFO - PID 3805 | Values: 897.8 900.0 911.1 912.8 923.9 20022.5 20271.0 20296.7 20318.6 20380.4 18476.9 18503.4 18888.8 18955.1 19052.5 953.8 978.2 982.6 983.7 986.5 989.0 989.1 989.8 989.8 991.0 985.2 1017.5 1025.0 1027.5 1035.9 1009.7 1018.4 1018.5 1018.5 1019.1 720.6 738.7 742.2 752.4 752.6 20617.8 20690.3 20726.3 20772.5 20775.6 19453.2 19460.9 19585.5 20537.5 20796.2 16671.6 16977.9 17239.3 17255.2 17402.0 3805.0 3826.1 3839.2 3845.9 3846.2 105845.5 127939.0 129468.0 131760.3 132835.0 17757.4 17774.0 17931.2 18149.5 18165.6 31077.0 31657.4 31683.5 31782.8 31847.5 9146.2 9399.4 9456.7 9475.5 9499.6 4432.6 4458.4 4501.5 4504.1 4508.5 5528.1 5614.9 5621.2 5628.5 5663.8 1046.4 1078.2 1084.5 1087.2 1091.4 577.5 590.3 609.6 613.7 619.1 11973.6 12157.5 12413.5 13077.3 13344.1 690.0 690.9 692.0 698.6 702.4 5376.8 5386.8 5415.4 5444.4 5486.5 123242.0 124679.0 125287.0 125384.0 129505.0 104992.5 106228.5 106877.0 110531.4 112016.4 92153.5 92685.1 94558.0 95009.0 96382.0 10101.6 10258.4 10281.5 10455.6 10552.0 43000.6 44454.0 44532.1 45010.0 45141.3 58245.1 58341.1 58406.4 58485.4 58929.1 15566.5 15644.5 15746.6 15755.4 15909.3 15910.4 16044.1 16187.7 16364.3 16369.6 14626.6 14886.0 15053.2 15162.5 15179.5 15529.0 15752.4 15767.2 15891.7 15907.3 15404.7 15441.8 15516.2 15583.3 15651.6 11816.4 11947.6 11960.4 11967.3 12208.4 11992.0 12137.8 12208.8 12300.0 12305.8 07:23:10 INFO - PID 3805 | -------- Summary: end -------- 07:23:10 INFO - PID 3805 | 07:23:11 INFO - TEST-INFO | 3805: exit 0 07:23:11 INFO - TEST-OK | dromaeo_css | took 1111878ms 07:23:11 INFO - TEST-START | kraken 07:23:11 INFO - Initialising browser for kraken test... 07:23:11 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48690/getInfo.html -profile /tmp/tmpkBdQkI/profile 07:23:11 INFO - TEST-INFO | started process 4169 (/builds/slave/test/build/application/firefox/firefox http://localhost:48690/getInfo.html) 07:23:16 INFO - TEST-INFO | 4169: exit 0 07:23:16 INFO - Browser initialized. 07:23:16 INFO - Running cycle 1/1 for kraken test... 07:23:16 INFO - Using env: {'DISPLAY': ':0', 07:23:16 INFO - 'HOME': '/home/cltbld', 07:23:16 INFO - 'JSGC_DISABLE_POISONING': '1', 07:23:16 INFO - 'LANG': 'en_US.UTF-8', 07:23:16 INFO - 'LANGUAGE': 'en_US:en', 07:23:16 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 07:23:16 INFO - 'LOGNAME': 'cltbld', 07:23:16 INFO - 'MAIL': '/var/mail/cltbld', 07:23:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:23:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:23:16 INFO - 'MOZ_CRASHREPORTER': '1', 07:23:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:16 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 07:23:16 INFO - 'MOZ_NO_REMOTE': '1', 07:23:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:23:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:23:16 INFO - 'NO_EM_RESTART': '1', 07:23:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:23:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:16 INFO - 'PWD': '/builds/slave/test', 07:23:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:23:16 INFO - 'RUST_BACKTRACE': 'full', 07:23:16 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:23:16 INFO - 'SHELL': '/bin/bash', 07:23:16 INFO - 'SHLVL': '1', 07:23:16 INFO - 'STYLO_FORCE_DISABLED': '1', 07:23:16 INFO - 'TERM': 'linux', 07:23:16 INFO - 'TMOUT': '86400', 07:23:16 INFO - 'USER': 'cltbld', 07:23:16 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506002068.466600-826066333', 07:23:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:16 INFO - '_': '/tools/buildbot/bin/python'} 07:23:16 INFO - TEST-INFO | started process 4406 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkBdQkI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:23:17 INFO - PID 4406 | 07:23:17 INFO - PID 4406 | (/builds/slave/test/build/application/firefox/firefox:4455): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:23:17 INFO - PID 4406 | 07:23:28 INFO - PID 4406 | RSS: Main: 154611712 07:23:28 INFO - PID 4406 | 07:23:30 INFO - PID 4406 | Cycle 1(1): loaded http://localhost:48690/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48690/tests/kraken/driver.html?testName=audio-beat-detection) 07:23:31 INFO - PID 4406 | RSS: Main: 161382400 07:23:31 INFO - PID 4406 | 07:23:34 INFO - PID 4406 | Cycle 1(1): loaded http://localhost:48690/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48690/tests/kraken/driver.html?testName=audio-dft) 07:23:34 INFO - PID 4406 | RSS: Main: 161067008 07:23:34 INFO - PID 4406 | 07:23:37 INFO - PID 4406 | Cycle 1(1): loaded http://localhost:48690/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48690/tests/kraken/driver.html?testName=audio-fft) 07:23:38 INFO - PID 4406 | RSS: Main: 156987392 07:23:38 INFO - PID 4406 | 07:23:40 INFO - PID 4406 | Cycle 1(1): loaded http://localhost:48690/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48690/tests/kraken/driver.html?testName=audio-oscillator) 07:23:41 INFO - PID 4406 | RSS: Main: 157417472 07:23:41 INFO - PID 4406 | 07:23:43 INFO - PID 4406 | Cycle 1(1): loaded http://localhost:48690/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48690/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:23:43 INFO - PID 4406 | RSS: Main: 157536256 07:23:43 INFO - PID 4406 | 07:23:47 INFO - PID 4406 | Cycle 1(1): loaded http://localhost:48690/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48690/tests/kraken/driver.html?testName=imaging-darkroom) 07:23:47 INFO - PID 4406 | RSS: Main: 159698944 07:23:47 INFO - PID 4406 | 07:23:51 INFO - PID 4406 | Cycle 1(1): loaded http://localhost:48690/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48690/tests/kraken/driver.html?testName=imaging-desaturate) 07:23:52 INFO - PID 4406 | RSS: Main: 160620544 07:23:52 INFO - PID 4406 | 07:23:55 INFO - PID 4406 | Cycle 1(1): loaded http://localhost:48690/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48690/tests/kraken/driver.html?testName=json-parse-financial) 07:23:55 INFO - PID 4406 | RSS: Main: 160645120 07:23:55 INFO - PID 4406 | 07:23:57 INFO - PID 4406 | Cycle 1(1): loaded http://localhost:48690/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48690/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:23:57 INFO - PID 4406 | RSS: Main: 160522240 07:23:57 INFO - PID 4406 | 07:23:59 INFO - PID 4406 | Cycle 1(1): loaded http://localhost:48690/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48690/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:24:00 INFO - PID 4406 | RSS: Main: 160690176 07:24:00 INFO - PID 4406 | 07:24:02 INFO - PID 4406 | Cycle 1(1): loaded http://localhost:48690/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48690/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:24:02 INFO - PID 4406 | RSS: Main: 157433856 07:24:02 INFO - PID 4406 | 07:24:05 INFO - PID 4406 | Cycle 1(1): loaded http://localhost:48690/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48690/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:24:05 INFO - PID 4406 | RSS: Main: 158162944 07:24:05 INFO - PID 4406 | 07:24:08 INFO - PID 4406 | Cycle 1(1): loaded http://localhost:48690/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48690/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:24:09 INFO - PID 4406 | RSS: Main: 158375936 07:24:09 INFO - PID 4406 | 07:24:11 INFO - PID 4406 | Cycle 1(1): loaded http://localhost:48690/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48690/tests/kraken/driver.html?testName=ai-astar) 07:24:11 INFO - PID 4406 | RSS: Main: 159506432 07:24:11 INFO - PID 4406 | 07:24:11 INFO - PID 4406 | __start_tp_report 07:24:11 INFO - PID 4406 | _x_x_mozilla_page_load 07:24:11 INFO - PID 4406 | _x_x_mozilla_page_load_details 07:24:11 INFO - PID 4406 | |i|pagename|runs| 07:24:11 INFO - PID 4406 | |0;ai-astar;108;107;107;107;113;107;107;108;106;106 07:24:11 INFO - PID 4406 | |1;audio-beat-detection;117;121;116;115;118;115;123;117;121;118 07:24:11 INFO - PID 4406 | |2;audio-dft;163;161;163;172;174;162;162;165;167;163 07:24:11 INFO - PID 4406 | |3;audio-fft;74;73;73;73;74;75;73;75;74;74 07:24:11 INFO - PID 4406 | |4;audio-oscillator;79;80;79;79;78;87;78;80;79;85 07:24:11 INFO - PID 4406 | |5;imaging-gaussian-blur;113;114;113;114;113;116;113;115;115;114 07:24:11 INFO - PID 4406 | |6;imaging-darkroom;153;148;149;150;147;149;148;148;148;147 07:24:11 INFO - PID 4406 | |7;imaging-desaturate;94;95;94;95;94;94;94;94;94;95 07:24:11 INFO - PID 4406 | |8;json-parse-financial;54;54;53;53;54;53;54;54;53;54 07:24:11 INFO - PID 4406 | |9;json-stringify-tinderbox;38;38;38;38;38;38;39;38;38;38 07:24:11 INFO - PID 4406 | |10;stanford-crypto-aes;74;72;77;76;73;76;72;76;76;74 07:24:11 INFO - PID 4406 | |11;stanford-crypto-ccm;116;108;118;118;109;115;118;114;108;113 07:24:11 INFO - PID 4406 | |12;stanford-crypto-pbkdf2;169;168;165;170;171;168;171;165;169;167 07:24:11 INFO - PID 4406 | |13;stanford-crypto-sha256-iterative;66;65;66;72;63;67;64;70;75;65 07:24:11 INFO - PID 4406 | __end_tp_report 07:24:11 INFO - PID 4406 | __start_cc_report 07:24:11 INFO - PID 4406 | _x_x_mozilla_cycle_collect,721 07:24:11 INFO - PID 4406 | __end_cc_report 07:24:11 INFO - PID 4406 | __startTimestamp1506003851512__endTimestamp 07:24:11 INFO - PID 4406 | 07:24:11 INFO - PID 4406 | ------- Summary: start ------- 07:24:11 INFO - PID 4406 | Number of tests: 14 07:24:11 INFO - PID 4406 | 07:24:11 INFO - PID 4406 | [#0] ai-astar Cycles:10 Average:107.60 Median:107.00 stddev:2.01 (1.9%) stddev-sans-first:2.13 07:24:11 INFO - PID 4406 | Values: 108.0 107.0 107.0 107.0 113.0 107.0 107.0 108.0 106.0 106.0 07:24:11 INFO - PID 4406 | 07:24:11 INFO - PID 4406 | [#1] audio-beat-detection Cycles:10 Average:118.10 Median:118.00 stddev:2.73 (2.3%) stddev-sans-first:2.86 07:24:11 INFO - PID 4406 | Values: 117.0 121.0 116.0 115.0 118.0 115.0 123.0 117.0 121.0 118.0 07:24:11 INFO - PID 4406 | 07:24:11 INFO - PID 4406 | [#2] audio-dft Cycles:10 Average:165.20 Median:164.00 stddev:4.47 (2.7%) stddev-sans-first:4.67 07:24:11 INFO - PID 4406 | Values: 163.0 161.0 163.0 172.0 174.0 162.0 162.0 165.0 167.0 163.0 07:24:11 INFO - PID 4406 | 07:24:11 INFO - PID 4406 | [#3] audio-fft Cycles:10 Average:73.80 Median:74.00 stddev:0.79 (1.1%) stddev-sans-first:0.83 07:24:11 INFO - PID 4406 | Values: 74.0 73.0 73.0 73.0 74.0 75.0 73.0 75.0 74.0 74.0 07:24:11 INFO - PID 4406 | 07:24:11 INFO - PID 4406 | [#4] audio-oscillator Cycles:10 Average:80.40 Median:79.50 stddev:3.06 (3.9%) stddev-sans-first:3.21 07:24:11 INFO - PID 4406 | Values: 79.0 80.0 79.0 79.0 78.0 87.0 78.0 80.0 79.0 85.0 07:24:11 INFO - PID 4406 | 07:24:11 INFO - PID 4406 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:1.05 (0.9%) stddev-sans-first:1.05 07:24:11 INFO - PID 4406 | Values: 113.0 114.0 113.0 114.0 113.0 116.0 113.0 115.0 115.0 114.0 07:24:11 INFO - PID 4406 | 07:24:11 INFO - PID 4406 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:148.50 stddev:1.77 (1.2%) stddev-sans-first:0.97 07:24:11 INFO - PID 4406 | Values: 153.0 148.0 149.0 150.0 147.0 149.0 148.0 148.0 148.0 147.0 07:24:11 INFO - PID 4406 | 07:24:11 INFO - PID 4406 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 07:24:11 INFO - PID 4406 | Values: 94.0 95.0 94.0 95.0 94.0 94.0 94.0 94.0 94.0 95.0 07:24:11 INFO - PID 4406 | 07:24:11 INFO - PID 4406 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:54.00 stddev:0.52 (1.0%) stddev-sans-first:0.53 07:24:11 INFO - PID 4406 | Values: 54.0 54.0 53.0 53.0 54.0 53.0 54.0 54.0 53.0 54.0 07:24:11 INFO - PID 4406 | 07:24:11 INFO - PID 4406 | [#9] json-stringify-tinderbox Cycles:10 Average:38.10 Median:38.00 stddev:0.32 (0.8%) stddev-sans-first:0.33 07:24:11 INFO - PID 4406 | Values: 38.0 38.0 38.0 38.0 38.0 38.0 39.0 38.0 38.0 38.0 07:24:11 INFO - PID 4406 | 07:24:11 INFO - PID 4406 | [#10] stanford-crypto-aes Cycles:10 Average:74.60 Median:76.00 stddev:1.84 (2.4%) stddev-sans-first:1.94 07:24:11 INFO - PID 4406 | Values: 74.0 72.0 77.0 76.0 73.0 76.0 72.0 76.0 76.0 74.0 07:24:11 INFO - PID 4406 | 07:24:11 INFO - PID 4406 | [#11] stanford-crypto-ccm Cycles:10 Average:113.70 Median:115.50 stddev:4.08 (3.5%) stddev-sans-first:4.25 07:24:11 INFO - PID 4406 | Values: 116.0 108.0 118.0 118.0 109.0 115.0 118.0 114.0 108.0 113.0 07:24:11 INFO - PID 4406 | 07:24:11 INFO - PID 4406 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.30 Median:169.00 stddev:2.16 (1.3%) stddev-sans-first:2.28 07:24:11 INFO - PID 4406 | Values: 169.0 168.0 165.0 170.0 171.0 168.0 171.0 165.0 169.0 167.0 07:24:11 INFO - PID 4406 | 07:24:11 INFO - PID 4406 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:66.50 stddev:3.83 (5.8%) stddev-sans-first:4.03 07:24:11 INFO - PID 4406 | Values: 66.0 65.0 66.0 72.0 63.0 67.0 64.0 70.0 75.0 65.0 07:24:11 INFO - PID 4406 | -------- Summary: end -------- 07:24:11 INFO - PID 4406 | 07:24:11 INFO - PID 4406 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 07:24:12 INFO - TEST-INFO | 4406: exit 0 07:24:12 INFO - TEST-OK | kraken | took 60705ms 07:24:12 INFO - SUITE-END | took 1172s 07:24:12 INFO - Completed test suite (00:19:32) 07:24:12 INFO - javascript benchmark 07:24:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8495.958320878302, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3125.359301343225, 3149.622045354558, 3157.494800831866, 3160.715535601795, 3170.2074481379664, 6137.38626137386, 6299.496040316775, 6330.841728956772, 6356.110144579762, 6365.108884756132, 6283.183186185801, 6310.810675679737, 6318.873622527547, 6320.652364119972, 6477.157969463975, 5790.507806836424, 5859.53123750099, 5869.148973398855, 5869.589128760988, 5912.763489460416, 5479.0959491683825, 5643.435656434344, 5694.402087780785, 5813.331466881299, 5841.912371314413, 5771.163181338703, 5778.451047150514, 5848.912266316009, 5858.326292476378, 5865.296164460271, 5656.123300888369, 5735.11105778605, 5780.826575202751, 5834.854128646775, 5843.941560584382, 5766.654000759968, 5808.738606762706, 5832.650040997553, 5839.591228613998, 5845.503132233765, 6256.749730010794, 6261.87476250477, 6262.060690896356, 6310.053491976194, 6322.146510221107, 6561.2782593914635, 6706.899396509057, 6760.391564759196, 6764.154480689914, 6779.694913728894, 6704.765333213363, 6756.054152418666, 6807.455403567703, 6833.3166683331765, 6846.110005699227, 6341.682915854235, 6357.586756860789, 6363.459105976044, 6365.077063825765, 6368.458681012119, 6929.341712537301, 6945.826354341182, 6948.5483443576, 6954.478414118961, 7020.824479387954, 6478.967605161944, 6612.404883560503, 6714.429273511806, 6765.898511522331, 6781.6609169541325, 6727.798166055026, 6794.694238759268, 6804.693788779517, 6810.523263371517, 6818.4886133540185, 6746.966265168643, 6760.391564759097, 6835.350641689031, 6836.248012718597, 6840.384365407137, 6508.837279067967, 6611.0, 6619.536632435684, 6630.270670226271, 6786.981952707133, 5233.136532472099, 5242.5281724644965, 5249.160134378558, 5268.762905669178, 5299.5760339172775, 4627.421572303462, 4631.675782695179, 4654.045920586272, 4660.813567457331, 4706.270528068155, 5755.971220143956, 5785.595008349375, 5793.362730099686, 5836.037053886146, 5868.735906884201, 6619.569727967763, 6735.0, 6738.7304507819135, 6773.322667733286, 6851.3491218334175, 5795.072788353843, 5858.56060795442, 5860.765569377262, 5865.912011319833, 5867.941320586825, 5729.28383952006, 5849.502792262705, 5891.116332550152, 5894.911576326359, 5898.705064746746, 6561.376669216417, 6580.506462015368, 6648.700808463631, 6651.401373876374, 6670.366315200048, 6581.276059633341, 6641.568298060611, 6735.393814556714, 6811.523193376416, 6882.105326307548, 6533.118029066015, 6533.281339052605, 6542.83642908912, 6548.0, 6550.770723024862, 6627.900581491378, 6636.203655561363, 6725.7893579156225, 6739.359760822714, 6741.932580674131, 6794.864102717819, 6817.761378351734, 6819.727210911508, 6883.3116688330765, 6920.446364290945, 6530.053142294246, 6558.245801732862, 6637.966810166112, 6638.137042184485, 6667.36660017317, 6572.80281591553, 6580.7038683260325, 6604.108445359815, 6612.8346791330605, 6616.338366163538, 6451.580647257913, 6458.483321334188, 6494.09082728409, 6551.377619126175, 6559.573627714183, 6510.73957041713, 6533.379328963741, 6611.041398997215, 6618.6690665467495, 6669.433098186514, 6277.874442511215, 6374.0, 6379.075034119934, 6385.233771947396, 6468.676566171766], "value": 6155.780194006215, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [869.6347534035705, 876.618670878168, 878.0999475537574, 882.5940067568918, 885.8316919785236, 40512.39231411528, 40985.38521922174, 41628.0, 41692.58307416921, 41796.79101604492, 38034.23931521368, 38125.428118578246, 38208.426873596916, 38238.61761382385, 38344.23311533768, 7099.077119974409, 7220.602866842321, 7222.783316500487, 7223.458240631948, 7225.710971561131, 7122.715091396338, 7185.964070179642, 7212.783616491513, 7220.386267167297, 7224.783256502314, 7789.298963093321, 7951.244631759973, 7957.124716281204, 7963.283304502594, 7967.681292748312, 7901.565413902233, 7959.880601790977, 7967.243111904418, 7972.282494575487, 7972.521648701097, 7681.57751323677, 7833.960830195812, 7897.5656338901335, 7904.249096335839, 7920.64357103926, 37246.25507489862, 37317.253654926746, 37531.81234093839, 37556.62443375558, 37576.81211593925, 3465.6534346565395, 3497.842597083137, 3506.36885360635, 3515.894523164284, 3523.982380088083, 31446.842765786023, 31504.212394690087, 31556.36887262265, 31580.52629210564, 31683.841580792177, 5130.97434512825, 5175.948240517584, 5180.0, 5210.114280572312, 5282.947170528322, 186964.0, 187452.0, 187570.0, 187607.0, 188098.0, 47777.0, 47813.52186478091, 48005.75997120062, 48067.759661202166, 48091.519084809406, 49880.50119498831, 50096.74951625219, 50171.74914125406, 50255.74872125689, 50359.74820125876, 15263.92368038175, 15394.153321567197, 15438.45965391206, 15511.844881551266, 15580.532584022498, 12660.683482913, 12675.556355527513, 12740.80888786669, 12777.361131943366, 12789.488420463264, 14133.787993179905, 14318.427262909367, 14318.85681143196, 14397.92801036009, 14495.565133046026, 5624.29696287964, 5792.913106303409, 5832.679202643895, 5843.357230704619, 5856.941430585724, 982.4449186209769, 1002.2032484175098, 1007.6573964851839, 1013.0780989299702, 1028.0490546244694, 22458.0, 22571.0, 22760.31719048431, 22808.885955570448, 22857.31428057161, 1113.6659002299277, 1114.4594871487323, 1115.8158903780786, 1128.4019469681082, 1133.4729350851728, 12009.579664711693, 12160.601530824068, 12208.145429820004, 12228.571999979958, 12285.262884226975, 227911.0, 228595.0, 228674.0, 229135.0, 229893.0, 44350.0, 45399.0, 50364.244536331986, 50779.74610126926, 50949.490505095215, 1459.314122362488, 1480.3042569992087, 1495.0, 1495.1253516692857, 1501.6996600679909, 26904.192874213804, 27138.0, 27566.862165689043, 27688.58467123035, 27708.0, 36652.45021324629, 36882.63117368899, 36969.6303036977, 36989.815050924575, 37014.25971480609, 188975.0, 190578.0, 190730.0, 191017.0, 191437.0, 31940.0, 33005.33989320248, 33230.0, 33238.833805830815, 33270.0, 42104.0, 42226.577734222265, 42471.0, 42614.36078458764, 42656.57343426526, 31503.84248078745, 31547.36905261836, 31664.366712666077, 31666.208344791565, 31959.0, 31033.069007929796, 31085.68914310828, 31165.376692465572, 31334.373312533167, 31433.8428307857, 35692.643073568936, 35880.4617930726, 35889.28221435609, 35962.82018589995, 36042.639573604974, 30720.23199419943, 30886.22784430407, 31039.844800775852, 31331.060068197992, 31502.0, 22171.55656886821, 22490.212842551085, 22592.435189120402, 22726.659100113182, 22731.772682273626], "value": 16989.999987900537, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.3797655496895, 587.3421767620264, 592.7777083593654, 596.7016491754123, 600.6006006006005, 21648.0, 22785.658215126787, 22846.200382986597, 22851.200207992722, 22874.1994030209, 23015.76984230157, 24056.0, 24217.636735448938, 24380.878095609496, 24411.00880804453, 6407.006913928349, 6427.196600424947, 6440.710168042449, 6443.420092191702, 6454.322296158906, 6173.814785556418, 6376.649284289362, 6403.199600049994, 6438.452731517827, 6474.5791523550815, 6370.84072898179, 6413.615183089007, 6417.486601071903, 6419.45434638054, 6422.678866056702, 6241.906371404432, 6398.072279519467, 6419.0, 6426.421622054014, 6536.084948107269, 6059.697015149269, 6065.757369705207, 6073.180120683695, 6081.665508397036, 6092.055731361646, 28601.0, 29064.564031539543, 29067.70932290671, 29090.41819163605, 29130.563041554393, 2036.378904434147, 2060.6599911014664, 2079.178724403852, 2080.5214800595795, 2083.0, 18986.14562344684, 19390.90304548482, 19874.403767886986, 19916.10377533, 19992.700109498368, 2442.242904699549, 2477.2444404456633, 2518.609615509599, 2529.0768869362732, 2531.696196456437, 118329.40835295855, 123354.38322808419, 135699.0, 145484.27257863642, 145534.27232863873, 14433.293543775733, 14459.349329280207, 14850.480233192002, 15106.942514024133, 15282.541523754306, 22911.19810806647, 23104.306870793567, 23117.653235201484, 23121.768782311963, 23145.537089258458, 10129.848052279222, 10189.439580823126, 10228.795424091477, 10234.59061637541, 10277.588896444207, 9356.625734970661, 9375.624975000923, 9428.905710942803, 9503.144716975366, 9503.619855205714, 9119.424604165599, 9131.269498440242, 9414.246860251164, 9446.0, 9536.332456727963, 2757.214193954713, 2800.80394372392, 2862.370278538718, 2899.739023487854, 2951.704829517031, 950.6577632052456, 956.8615736937772, 961.8893827209821, 967.4195482710318, 978.4471773448122, 18398.81601183998, 18522.444326670222, 18569.5357616058, 18965.90517047406, 19029.238830446902, 997.9272282296561, 1001.4683556905063, 1008.1732978957185, 1011.6206422591529, 1022.5960745505483, 10437.321574097812, 10445.425501597485, 10454.0, 10652.360858348524, 10751.19366047534, 455225.0, 463025.0, 480225.0, 481455.0, 485239.0, 112252.0, 115416.0, 115587.42206289082, 116836.41581792037, 117502.412487937, 1031.664708969588, 1071.5927947379946, 1135.3925649777495, 1155.3876445483907, 1183.3964678014274, 19488.317908873123, 19504.414867553995, 19580.510487237934, 19738.0, 19992.400227993185, 56292.718536407054, 56460.0, 58914.11628825485, 58943.70528147332, 59180.0, 71222.64388678024, 71228.28771712424, 71398.0, 72484.63757681177, 73136.63431682807, 13949.3722782473, 14190.503332383318, 14270.500532481314, 14273.286335683382, 14308.49920252786, 21864.78135218691, 21892.89053554722, 21908.12367505282, 22027.66958495592, 22216.444588885406, 16891.070991095607, 17109.401170958958, 17727.0, 17858.107094645475, 17901.820981790537, 15551.766723499382, 15553.377864885279, 16030.519084427486, 16431.83568164303, 16657.416990405276, 17734.024628645548, 17771.911140444216, 17794.822051779316, 18086.90956545209, 18290.451286461426, 13855.307234638027, 13969.161850289016, 14031.859681403464, 14077.718445631235, 14200.50298239598, 16225.458581434745, 16285.430009949594, 16439.342426302814, 16451.42420015294, 16601.0], "value": 11805.948010244623, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1329.3552626975916, 1421.0478979084012, 1439.0574173916089, 1449.188454465499, 1453.1208618785633, 15032.849671503296, 15635.687286254282, 15721.84278157221, 15757.369705211806, 15761.763573546377, 15507.612309692264, 15521.844781552181, 15586.064836109841, 15641.374345026214, 15665.0, 2777.777777777783, 2826.8303901765858, 2847.615571897788, 2860.284928767808, 2861.6995215502384, 2788.10780550224, 2819.7885158613085, 2823.5058864698594, 2834.702356252584, 2838.9858050709718, 2733.2346942856034, 2846.131929761422, 2846.245744877609, 2847.330877243846, 2847.900323488678, 2812.6062351270734, 2852.3297025199063, 2876.3815779607276, 2881.84149871758, 2884.0, 2758.255271076798, 2860.356419805548, 2878.568214767781, 2880.8127471714483, 2883.956740648892, 15242.618934526725, 15256.847431525654, 15380.0, 15414.383424663, 15425.305861236271, 7961.681532738684, 8167.183281671785, 8212.219839115274, 8222.671093156267, 8239.340852731768, 5146.122070802597, 5278.841634750964, 5363.704996225206, 5404.91892621611, 5417.783288668448, 1972.1815446589792, 2014.798520147988, 2025.382258411184, 2072.243631074662, 2075.7094006839056, 26915.73084269152, 27136.45727085467, 27152.86423567889, 27188.45623087547, 27282.45435091307, 6988.126484189476, 7567.205443428361, 7594.81012974669, 7851.9214807851195, 7891.802704932423, 17270.13649317529, 17571.648567028587, 17612.823871761117, 17619.295228190986, 17633.911830441022, 8126.0, 8203.261706446448, 8217.58912054395, 8275.83448331042, 8284.50292982423, 7452.217517160729, 7546.773596792105, 7565.243475652391, 7720.729774457867, 7720.7683769487, 5424.349078110652, 5498.120300751861, 5549.361823390362, 5572.219889215513, 5595.132754423071, 1555.8288588255282, 1571.4028669105667, 1574.0162398500936, 1582.1614544291544, 1596.2497626115708, 880.3309484791605, 901.3370331737933, 907.2197909797569, 912.493566070837, 918.0635751533398, 7222.313880181375, 7358.889616655754, 7436.293552112541, 8693.608787604573, 8710.12898710124, 687.8933765266391, 699.2832346844424, 699.9720011199495, 704.0671110778239, 706.261956255714, 4550.658700597469, 4603.332516785047, 4620.19146649335, 4631.930521042187, 4638.373819534319, 21777.34667959964, 22376.32871013872, 22493.4376640582, 22590.322290331318, 22628.773712262668, 20532.0, 21174.153033878472, 21451.46371340729, 21566.353009409744, 21713.999999999683, 10565.260431769857, 10709.46452677363, 10713.892861071445, 10719.196060295353, 10752.784944301071, 7912.32745216663, 8356.065328512654, 8477.15228477172, 8508.0, 8573.22840944293, 18681.81318186801, 19246.518837029187, 19597.804021959597, 19625.70561441608, 19767.308144214883, 19515.316963906196, 19725.901370493055, 19760.90119549393, 19819.801801982372, 19887.60224795467, 10885.401302928414, 11250.437478125898, 11263.324200547993, 11263.718407039889, 11273.7745245093, 14052.297385130498, 14077.366518506487, 14110.0, 14180.787288190479, 14186.858131418554, 10924.453777311262, 11137.331760094421, 11339.319640821577, 11431.428428578703, 11491.425428728697, 10993.450327483433, 11026.338419694523, 11100.666979990614, 11187.384693841917, 11279.492422841156, 9965.950170249102, 10132.696019119438, 10133.442660653734, 10139.290249682452, 10141.746456338651, 6536.934630653633, 6555.3772391622715, 6584.374484423972, 6594.70323835419, 6699.19609646826, 6910.067140935909, 6936.375726184668, 6948.096747422803, 7025.613591252326, 7097.325754053357], "value": 6711.923926077656, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [513.9897202055957, 514.2106865960749, 532.438277617114, 542.0405881589589, 544.3196004993757, 6130.44825965663, 6199.287081985573, 6246.4077407875675, 6291.15069465622, 6323.399277068677, 6148.3851614838495, 6152.230971128609, 6227.43953044226, 6251.781187658433, 6306.558540902139, 5206.401263854667, 5224.869378265555, 5230.320058392404, 5263.394709608387, 5281.521174071247, 4918.409790825106, 5075.695458272497, 5100.821471248507, 5207.140821764423, 5256.684598924076, 4996.875078123057, 5045.722485263309, 5050.838307189349, 5090.287359769617, 5093.719845408501, 5033.590594633509, 5073.822416215433, 5086.79652813887, 5092.9236061459105, 5137.51193636604, 4541.182587134314, 4546.386237857913, 4567.634589232854, 4573.954260457419, 4580.0, 6204.720787564525, 6217.87564248717, 6235.9376406235815, 6252.906206406908, 6304.1804565406665, 5785.40901252159, 5792.507636850873, 5808.82573522795, 5828.863371642531, 5837.6497410155525, 6491.67541622917, 6515.543911926167, 6515.93484065158, 6590.505712071614, 6616.966915165442, 4886.780094895738, 4917.459079501252, 4942.739601401619, 4965.354503914504, 4972.8508144755715, 6946.9652651736415, 6953.165620125566, 6963.8607227855155, 6983.790486285368, 7022.859542809167, 5032.899342013139, 5064.5819170632285, 5067.847964561069, 5069.898602028013, 5107.106256405114, 5087.26234695967, 5151.91809719963, 5173.430922598511, 5176.870578235575, 5191.351081114861, 5801.3038435388025, 5808.3901190375245, 5823.650580965155, 5832.62087964281, 5834.5624078194305, 6340.50998015466, 6595.208574971034, 6612.801615951433, 6692.297308782605, 6756.966215168893, 1655.7185278502684, 1699.4137022727139, 1743.3898135652673, 1748.7726595542752, 1783.0, 1222.6515443098851, 1224.2776761710634, 1235.3020543392954, 1242.8073648584484, 1246.8005119180887, 5504.174373843955, 5529.419410961871, 5635.69003704792, 5642.548596112301, 5664.49019588239, 6675.232348279913, 6717.899231511531, 6767.458603311723, 6776.966115169491, 6864.730024945401, 5721.170430287668, 5724.137931034483, 5745.655260684289, 5752.194692743019, 5766.798162064308, 3491.022513696169, 3530.5233793437556, 3572.214112895159, 3604.13500759821, 3604.2431089471506, 6410.583312084699, 6464.22429308486, 6523.902141467882, 6541.443977261891, 6590.2421221560135, 6840.776747557064, 6845.315468453115, 6890.2420733719255, 6925.445964322842, 6939.201991771011, 6406.743730250738, 6409.615423074537, 6488.156539649815, 6520.380563846427, 6526.967365163238, 6492.48060155177, 6568.277489476058, 6610.305917878553, 6642.535022548375, 6667.899981500184, 6541.6402097885075, 6611.528972261314, 6619.470442364503, 6624.542600627854, 6713.496487763339, 6257.217847769029, 6353.491720662429, 6413.743450261937, 6457.903131453126, 6464.612123272619, 4956.3804524434445, 4960.379952505937, 4967.652264341606, 5002.599792016703, 5009.572271902491, 6349.841253968503, 6652.438811057681, 6754.324567543206, 6754.898676519758, 6799.218089919723, 6341.365863413622, 6432.517561182836, 6447.806565803034, 6468.676566171766, 6477.0, 6353.777617783356, 6427.485801135991, 6429.292777794345, 6498.740050397932, 6541.313162117909, 6148.110388117578, 6360.4911607072245, 6388.329225431448, 6488.805335839932, 6564.770233041821, 6477.1579694639395, 6509.479241660751, 6516.641584712696, 6574.901376479261, 6638.302978187221, 6335.556511044183, 6393.0, 6398.48812095022, 6403.391677790602, 6419.165508483868], "value": 5081.34710629476, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [897.7755561109722, 900.0369604523163, 911.1025639744851, 912.8219997100559, 923.875276837627, 20022.499437514052, 20270.98645067746, 20296.69554956673, 20318.59362812743, 20380.388588342335, 18476.907615461903, 18503.444896653124, 18888.811111888877, 18955.14701838417, 19052.523686907833, 953.8473844184932, 978.1685567267837, 982.6069572171117, 983.7098056073439, 986.4623780039859, 988.9752756181117, 989.1246247071358, 989.7773001074737, 989.806987637411, 990.9900900991006, 985.2265971212599, 1017.4505766885873, 1024.9846252306222, 1027.547878933267, 1035.9223058270659, 1009.6617633092849, 1018.4398580780615, 1018.4602160854722, 1018.5416562546884, 1019.0573719309609, 720.5748608321115, 738.7303634173542, 742.1502379775181, 752.3943225703307, 752.5860776572863, 20617.793822061736, 20690.275840345515, 20726.274580389763, 20772.480687982923, 20775.58448831015, 19453.221871125137, 19460.902695486573, 19585.510362240915, 20537.48656283605, 20796.16815327385, 16671.583210419714, 16977.915110424492, 17239.31042758288, 17255.22351494186, 17402.0, 3804.9809750951067, 3826.081740382316, 3839.17457746583, 3845.9230815383535, 3846.1730727893637, 105845.47077264641, 127939.0, 129468.0, 131760.34119829437, 132835.0, 17757.378491752985, 17774.0, 17931.193096310697, 18149.455516334532, 18165.636687266444, 31077.0, 31657.366852662817, 31683.542917450886, 31782.84108579442, 31847.52228716571, 9146.176844084064, 9399.436033837992, 9456.716298511055, 9475.478848663251, 9499.572519236652, 4432.623227025674, 4458.35353873693, 4501.504834468205, 4504.099180163915, 4508.504064552896, 5528.06022976095, 5614.85962850932, 5621.15682647598, 5628.465295796893, 5663.801766938137, 1046.4453839465095, 1078.1536493852445, 1084.4957094950885, 1087.1846115413439, 1091.410638255349, 577.5091172503422, 590.3004939147124, 609.6403122157948, 613.7268915332724, 619.0559396919733, 11973.640790776291, 12157.452914618863, 12413.503459861504, 13077.346132693518, 13344.132631378929, 689.9827504312433, 690.8756423843656, 692.003514938487, 698.552926127279, 702.3538344722867, 5376.838694839161, 5386.782339889827, 5415.431379705153, 5444.40111587725, 5486.451354864562, 123242.0, 124679.0, 125287.0, 125384.0, 129505.0, 104992.47503762432, 106228.46885765676, 106877.0, 110531.44734276438, 112016.43991779989, 92153.5392323034, 92685.07314927033, 94558.0, 95009.0, 96382.0, 10101.646442374482, 10258.384496930208, 10281.537330819981, 10455.634052808115, 10552.0, 43000.56999429966, 44454.0, 44532.10935781331, 45010.0, 45141.32288015748, 58245.12632310434, 58341.12488312764, 58406.4159358401, 58485.415145848, 58929.11606325994, 15566.455174068853, 15644.452444164399, 15746.606334841721, 15755.369785208462, 15909.284082216096, 15910.443134490237, 16044.117573533102, 16187.67624647477, 16364.2636081379, 16369.590760230612, 14626.634334141732, 14886.0, 15053.247337632856, 15162.469313574413, 15179.544613661608, 15529.0, 15752.369905203663, 15767.211639418212, 15891.682166356377, 15907.28417221251, 15404.691906162037, 15441.768373474182, 15516.22418879074, 15583.298751556435, 15651.608709782347, 11816.350100744541, 11947.581834635746, 11960.401979901144, 11967.341796201292, 12208.389580521116, 11992.0, 12137.817932731192, 12208.75582488363, 12300.0, 12305.815412768636], "value": 8929.887943795524, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1417.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 107.0, 107.0, 107.0, 113.0, 107.0, 107.0, 108.0, 106.0, 106.0], "value": 107.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 121.0, 116.0, 115.0, 118.0, 115.0, 123.0, 117.0, 121.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 163.0, 172.0, 174.0, 162.0, 162.0, 165.0, 167.0, 163.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 73.0, 73.0, 74.0, 75.0, 73.0, 75.0, 74.0, 74.0], "value": 73.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 79.0, 79.0, 78.0, 87.0, 78.0, 80.0, 79.0, 85.0], "value": 80.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 114.0, 113.0, 116.0, 113.0, 115.0, 115.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 148.0, 149.0, 150.0, 147.0, 149.0, 148.0, 148.0, 148.0, 147.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 53.0, 54.0, 53.0, 54.0, 54.0, 53.0, 54.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 39.0, 38.0, 38.0, 38.0], "value": 38.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 77.0, 76.0, 73.0, 76.0, 72.0, 76.0, 76.0, 74.0], "value": 74.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 108.0, 118.0, 118.0, 109.0, 115.0, 118.0, 114.0, 108.0, 113.0], "value": 113.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 168.0, 165.0, 170.0, 171.0, 168.0, 171.0, 165.0, 169.0, 167.0], "value": 168.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 72.0, 63.0, 67.0, 64.0, 70.0, 75.0, 65.0], "value": 67.3, "unit": "score"}]}]} 07:24:12 INFO - Return code: 0 07:24:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:24:12 INFO - # TBPL SUCCESS # 07:24:12 INFO - Running post-action listener: _package_coverage_data 07:24:12 INFO - Running post-action listener: _resource_record_post_action 07:24:12 INFO - [mozharness: 2017-09-21 14:24:12.294114Z] Finished run-tests step (success) 07:24:12 INFO - Running post-run listener: _resource_record_post_run 07:24:12 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 9379840; Write bytes: 418988032; Read time: 2972; Write time: 501324 07:24:12 INFO - TinderboxPrint: CPU usage
13.1% 07:24:12 INFO - TinderboxPrint: I/O read bytes / time
9,379,840 / 2,972 07:24:12 INFO - TinderboxPrint: I/O write bytes / time
418,988,032 / 501,324 07:24:12 INFO - TinderboxPrint: CPU idle
8,247.8 (86.9%) 07:24:12 INFO - TinderboxPrint: CPU user
1,193.4 (12.6%) 07:24:12 INFO - TinderboxPrint: Swap in / out
0 / 0 07:24:12 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 109371392; Read time: 248; Write time: 108084 07:24:12 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 07:24:12 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 7221248; Write bytes: 260550656; Read time: 2080; Write time: 333720 07:24:12 INFO - Running post-run listener: _upload_blobber_files 07:24:12 INFO - Blob upload gear active. 07:24:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:24:12 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 07:24:12 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'] 07:24:12 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 07:24:13 INFO - (blobuploader) - INFO - Open directory for files ... 07:24:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 07:24:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:24:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:24:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 07:24:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:24:14 INFO - (blobuploader) - INFO - Done attempting. 07:24:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:24:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:24:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:24:15 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:24:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:24:15 INFO - (blobuploader) - INFO - Done attempting. 07:24:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:24:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:24:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:24:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:24:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:24:22 INFO - (blobuploader) - INFO - Done attempting. 07:24:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 07:24:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:24:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:24:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 07:24:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:24:23 INFO - (blobuploader) - INFO - Done attempting. 07:24:23 INFO - (blobuploader) - INFO - Iteration through files over. 07:24:23 INFO - Return code: 0 07:24:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:24:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:24:23 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8cb7b31550a218861b8bbc475d18d89e008f8e2dd836040c9e5a888fbbc14e62d59ade93c1345888117f2f44a7949e09f717ede3188506b2587449fb79c1be03", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5edc563e237fb8cf8f9eb2abbbedf8104eb4c6dc139ab1ac40ad755953103043cd8ef3fc87897cdaab3677eaae00caa6ea3a0cfed96c2aee1603fbcdda281ac5", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f0b58d32fc127d3262128e80c70cca9dc9ee24486e75743241e928131cd57b857f976d894ebc957c3e2dd818a2426acc5c34873a9592d7f1f1067683002c8340", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6cadcc7423c52473f0763d33c11287b4873bbcc59ae203665732d3d353ec7c2727fabf3358323b3552746e6f1b19dd840d0ee461db7f5fc00ec4511fd2871d2b"} 07:24:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:24:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:24:23 INFO - Contents: 07:24:23 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8cb7b31550a218861b8bbc475d18d89e008f8e2dd836040c9e5a888fbbc14e62d59ade93c1345888117f2f44a7949e09f717ede3188506b2587449fb79c1be03", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5edc563e237fb8cf8f9eb2abbbedf8104eb4c6dc139ab1ac40ad755953103043cd8ef3fc87897cdaab3677eaae00caa6ea3a0cfed96c2aee1603fbcdda281ac5", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f0b58d32fc127d3262128e80c70cca9dc9ee24486e75743241e928131cd57b857f976d894ebc957c3e2dd818a2426acc5c34873a9592d7f1f1067683002c8340", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6cadcc7423c52473f0763d33c11287b4873bbcc59ae203665732d3d353ec7c2727fabf3358323b3552746e6f1b19dd840d0ee461db7f5fc00ec4511fd2871d2b"} 07:24:23 INFO - Running post-run listener: copy_logs_to_upload_dir 07:24:23 INFO - Copying logs to upload dir... 07:24:23 INFO - mkdir: /builds/slave/test/build/upload/logs 07:24:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.762981 ========= master_lag: -0.37 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-09-21 07:24:23.066145) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-21 07:24:23.070152) ========= 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=836cfdc75598d54cb747368e000001a9-1506002068.466600-826066333 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/8cb7b31550a218861b8bbc475d18d89e008f8e2dd836040c9e5a888fbbc14e62d59ade93c1345888117f2f44a7949e09f717ede3188506b2587449fb79c1be03", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5edc563e237fb8cf8f9eb2abbbedf8104eb4c6dc139ab1ac40ad755953103043cd8ef3fc87897cdaab3677eaae00caa6ea3a0cfed96c2aee1603fbcdda281ac5", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f0b58d32fc127d3262128e80c70cca9dc9ee24486e75743241e928131cd57b857f976d894ebc957c3e2dd818a2426acc5c34873a9592d7f1f1067683002c8340", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6cadcc7423c52473f0763d33c11287b4873bbcc59ae203665732d3d353ec7c2727fabf3358323b3552746e6f1b19dd840d0ee461db7f5fc00ec4511fd2871d2b"} build_url:https://queue.taskcluster.net/v1/task/OR_WzdNeS6ee0KU9V4iMiw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011173 build_url: 'https://queue.taskcluster.net/v1/task/OR_WzdNeS6ee0KU9V4iMiw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8cb7b31550a218861b8bbc475d18d89e008f8e2dd836040c9e5a888fbbc14e62d59ade93c1345888117f2f44a7949e09f717ede3188506b2587449fb79c1be03", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5edc563e237fb8cf8f9eb2abbbedf8104eb4c6dc139ab1ac40ad755953103043cd8ef3fc87897cdaab3677eaae00caa6ea3a0cfed96c2aee1603fbcdda281ac5", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f0b58d32fc127d3262128e80c70cca9dc9ee24486e75743241e928131cd57b857f976d894ebc957c3e2dd818a2426acc5c34873a9592d7f1f1067683002c8340", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6cadcc7423c52473f0763d33c11287b4873bbcc59ae203665732d3d353ec7c2727fabf3358323b3552746e6f1b19dd840d0ee461db7f5fc00ec4511fd2871d2b"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-21 07:24:23.112393) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 07:24:23.117055) ========= 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=836cfdc75598d54cb747368e000001a9-1506002068.466600-826066333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004451 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 07:24:23.196506) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-21 07:24:23.196817) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-21 07:24:23.197099) ========= ========= Total master_lag: -0.16 =========