builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-078 starttime: 1505367925.12 results: success (0) revision: 6f08f91f8db00d385e5d564b0102bf0dece39f6f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-13 22:45:25.122990) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-13 22:45:25.127480) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-13 22:45:25.127812) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-13 22:45:25.208442) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 22:45:25.211761) ========= 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=dac658600622fd96716c9acf000001b3-1505365421.901742-1376979000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-13 22:45:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 93.6M=0s 2017-09-13 22:45:25 (93.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.076727 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 22:45:25.308162) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 22:45:25.308515) ========= 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=dac658600622fd96716c9acf000001b3-1505365421.901742-1376979000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016814 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 22:45:25.363146) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 10 secs) (at 2017-09-13 22:45:25.363446) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6f08f91f8db00d385e5d564b0102bf0dece39f6f --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 6f08f91f8db00d385e5d564b0102bf0dece39f6f --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=dac658600622fd96716c9acf000001b3-1505365421.901742-1376979000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-13 22:45:25,421 truncating revision to first 12 chars 2017-09-13 22:45:25,421 Setting DEBUG logging. 2017-09-13 22:45:25,421 attempt 1/10 2017-09-13 22:45:25,421 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6f08f91f8db0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-13 22:45:26,081 sleeping for 9.00s (attempt 1/10) 2017-09-13 22:45:35,091 attempt 2/10 2017-09-13 22:45:35,091 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6f08f91f8db0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-13 22:45:35,881 unpacking tar archive at: mozilla-central-6f08f91f8db0/testing/mozharness/ program finished with exit code 0 elapsedTime=10.764042 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 10 secs) (at 2017-09-13 22:45:36.151737) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-13 22:45:36.152100) ========= script_repo_revision: 6f08f91f8db00d385e5d564b0102bf0dece39f6f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-13 22:45:36.152504) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-13 22:45:36.152779) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-13 22:45:36.166444) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-09-13 22:45:36.166837) ========= /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=dac658600622fd96716c9acf000001b3-1505365421.901742-1376979000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:45:36 INFO - MultiFileLogger online at 20170913 22:45:36 in /builds/slave/test 22:45:36 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 22:45:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:45:36 INFO - {'append_to_log': False, 22:45:36 INFO - 'base_work_dir': '/builds/slave/test', 22:45:36 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 22:45:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:45:36 INFO - 'branch': 'Firefox-Non-PGO', 22:45:36 INFO - 'buildbot_json_path': 'buildprops.json', 22:45:36 INFO - 'code_coverage': False, 22:45:36 INFO - 'config_files': ('talos/linux_config.py',), 22:45:36 INFO - 'default_actions': ('clobber', 22:45:36 INFO - 'read-buildbot-config', 22:45:36 INFO - 'download-and-extract', 22:45:36 INFO - 'populate-webroot', 22:45:36 INFO - 'create-virtualenv', 22:45:36 INFO - 'install', 22:45:36 INFO - 'setup-mitmproxy', 22:45:36 INFO - 'run-tests'), 22:45:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:45:36 INFO - 'disable_ccov_upload': False, 22:45:36 INFO - 'disable_stylo': False, 22:45:36 INFO - 'download_minidump_stackwalk': True, 22:45:36 INFO - 'download_symbols': 'ondemand', 22:45:36 INFO - 'enable_stylo': False, 22:45:36 INFO - 'enable_webrender': False, 22:45:36 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 22:45:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:45:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:45:36 INFO - 'gecko_profile': False, 22:45:36 INFO - 'gecko_profile_interval': 0, 22:45:36 INFO - 'installer_path': 'installer.exe', 22:45:36 INFO - 'log_level': 'info', 22:45:36 INFO - 'log_name': 'talos', 22:45:36 INFO - 'log_to_console': True, 22:45:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:45:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:45:36 INFO - 'opt_config_files': (), 22:45:36 INFO - 'pip_index': False, 22:45:36 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 22:45:36 INFO - 'system_bits': '32', 22:45:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:45:36 INFO - 'title': 'talos-linux64-ix-078', 22:45:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:45:36 INFO - 'use_talos_json': True, 22:45:36 INFO - 'verify': 'False', 22:45:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:45:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:45:36 INFO - 'work_dir': 'build'} 22:45:36 INFO - [mozharness: 2017-09-14 05:45:36.369699Z] Running clobber step. 22:45:36 INFO - Running pre-action listener: _resource_record_pre_action 22:45:36 INFO - Running main action method: clobber 22:45:36 INFO - rmtree: /builds/slave/test/build 22:45:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:45:37 INFO - Running post-action listener: _resource_record_post_action 22:45:37 INFO - [mozharness: 2017-09-14 05:45:37.872536Z] Finished clobber step (success) 22:45:37 INFO - [mozharness: 2017-09-14 05:45:37.872634Z] Running read-buildbot-config step. 22:45:37 INFO - Running pre-action listener: _resource_record_pre_action 22:45:37 INFO - Running main action method: read_buildbot_config 22:45:37 INFO - Using buildbot properties: 22:45:37 INFO - { 22:45:37 INFO - "project": "", 22:45:37 INFO - "product": "firefox", 22:45:37 INFO - "who": "jdolske@mozilla.com", 22:45:37 INFO - "installer_path": "public/build/target.tar.bz2", 22:45:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 22:45:37 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 22:45:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 22:45:37 INFO - "stage_platform": "linux64", 22:45:37 INFO - "basedir": "/builds/slave/test", 22:45:37 INFO - "buildnumber": 15, 22:45:37 INFO - "platform": "ubuntu64_hw", 22:45:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:45:37 INFO - "slavebuilddir": "test", 22:45:37 INFO - "taskId": "G0DAwdUpRlm-KfT-d1MChg", 22:45:37 INFO - "branch": "mozilla-central", 22:45:37 INFO - "script_repo_revision": "production", 22:45:37 INFO - "revision": "6f08f91f8db00d385e5d564b0102bf0dece39f6f", 22:45:37 INFO - "slavename": "talos-linux64-ix-078", 22:45:37 INFO - "repo_path": "mozilla-central" 22:45:37 INFO - } 22:45:37 INFO - Finding installer, test and symbols from parent task. 22:45:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G0DAwdUpRlm-KfT-d1MChg'}, attempt #1 22:45:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G0DAwdUpRlm-KfT-d1MChg'}, attempt #1 22:45:38 INFO - Task dependencies: XkYgQGM7RR6WsMLSikInwA 22:45:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XkYgQGM7RR6WsMLSikInwA'}, attempt #1 22:45:39 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/XkYgQGM7RR6WsMLSikInwA/artifacts/public/build/target.tar.bz2 22:45:39 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/XkYgQGM7RR6WsMLSikInwA/artifacts/public/build/target.test_packages.json 22:45:39 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/XkYgQGM7RR6WsMLSikInwA/artifacts/public/build/target.crashreporter-symbols.zip 22:45:39 INFO - Running post-action listener: _resource_record_post_action 22:45:39 INFO - [mozharness: 2017-09-14 05:45:39.590133Z] Finished read-buildbot-config step (success) 22:45:39 INFO - [mozharness: 2017-09-14 05:45:39.590349Z] Running download-and-extract step. 22:45:39 INFO - Running pre-action listener: _resource_record_pre_action 22:45:39 INFO - Running main action method: download_and_extract 22:45:39 INFO - mkdir: /builds/slave/test/build/tests 22:45:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:45:39 INFO - trying https://queue.taskcluster.net/v1/task/XkYgQGM7RR6WsMLSikInwA/artifacts/public/build/target.test_packages.json 22:45:39 INFO - Downloading https://queue.taskcluster.net/v1/task/XkYgQGM7RR6WsMLSikInwA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 22:45:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XkYgQGM7RR6WsMLSikInwA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 22:45:40 INFO - Downloaded 989 bytes. 22:45:40 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 22:45:40 INFO - Using the following test package requirements: 22:45:40 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 22:45:40 INFO - u'common': [u'target.common.tests.zip'], 22:45:40 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 22:45:40 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 22:45:40 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 22:45:40 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 22:45:40 INFO - u'mozbase': [u'target.common.tests.zip'], 22:45:40 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 22:45:40 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 22:45:40 INFO - u'web-platform': [u'target.common.tests.zip', 22:45:40 INFO - u'target.web-platform.tests.tar.gz'], 22:45:40 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 22:45:40 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 22:45:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XkYgQGM7RR6WsMLSikInwA/artifacts/public/build/target.common.tests.zip 22:45:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XkYgQGM7RR6WsMLSikInwA/artifacts/public/build/target.common.tests.zip'}, attempt #1 22:45:40 INFO - Fetch https://queue.taskcluster.net/v1/task/XkYgQGM7RR6WsMLSikInwA/artifacts/public/build/target.common.tests.zip into memory 22:45:41 INFO - Content-Length response header: 54572630 22:45:41 INFO - Bytes received: 54572630 22:45:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XkYgQGM7RR6WsMLSikInwA/artifacts/public/build/target.talos.tests.zip 22:45:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XkYgQGM7RR6WsMLSikInwA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 22:45:52 INFO - Fetch https://queue.taskcluster.net/v1/task/XkYgQGM7RR6WsMLSikInwA/artifacts/public/build/target.talos.tests.zip into memory 22:45:53 INFO - Content-Length response header: 14500356 22:45:53 INFO - Bytes received: 14500356 22:45:54 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')]} 22:45:54 INFO - trying https://queue.taskcluster.net/v1/task/XkYgQGM7RR6WsMLSikInwA/artifacts/public/build/target.tar.bz2 22:45:54 INFO - Downloading https://queue.taskcluster.net/v1/task/XkYgQGM7RR6WsMLSikInwA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 22:45:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XkYgQGM7RR6WsMLSikInwA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 22:45:55 INFO - Downloaded 61280115 bytes. 22:45:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XkYgQGM7RR6WsMLSikInwA/artifacts/public/build/target.tar.bz2 22:45:55 INFO - mkdir: /builds/slave/test/properties 22:45:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:45:55 INFO - Writing to file /builds/slave/test/properties/build_url 22:45:55 INFO - Contents: 22:45:55 INFO - build_url:https://queue.taskcluster.net/v1/task/XkYgQGM7RR6WsMLSikInwA/artifacts/public/build/target.tar.bz2 22:45:55 INFO - Running post-action listener: _resource_record_post_action 22:45:55 INFO - Running post-action listener: find_tests_for_verification 22:45:55 INFO - Running post-action listener: set_extra_try_arguments 22:45:55 INFO - [mozharness: 2017-09-14 05:45:55.205219Z] Finished download-and-extract step (success) 22:45:55 INFO - [mozharness: 2017-09-14 05:45:55.205389Z] Running populate-webroot step. 22:45:55 INFO - Running pre-action listener: _resource_record_pre_action 22:45:55 INFO - Running main action method: populate_webroot 22:45:55 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:45:55 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 22:45:55 INFO - 'tests': ['tresize', 22:45:55 INFO - 'tcanvasmark']}, 22:45:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:45:55 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 22:45:55 INFO - 'tests': ['dromaeo_css', 22:45:55 INFO - 'kraken']}, 22:45:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 22:45:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:45:55 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 22:45:55 INFO - 'talos_options': ['--disable-stylo'], 22:45:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:45:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 22:45:55 INFO - 'tests': ['damp', 'tps']}, 22:45:55 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 22:45:55 INFO - 'talos_options': ['--disable-stylo'], 22:45:55 INFO - 'tests': ['damp', 'tps']}, 22:45:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:45:55 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 22:45:55 INFO - 'tests': ['dromaeo_dom']}, 22:45:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 22:45:55 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 22:45:55 INFO - 'tests': ['basic_compositor_video', 22:45:55 INFO - 'glvideo']}, 22:45:55 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 22:45:55 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 22:45:55 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 22:45:55 INFO - 'talos_options': ['--disable-stylo'], 22:45:55 INFO - 'tests': ['ts_paint_webext', 22:45:55 INFO - 'tp5o_webext']}, 22:45:55 INFO - 'other-e10s': {'tests': ['a11yr', 22:45:55 INFO - 'ts_paint', 22:45:55 INFO - 'tpaint', 22:45:55 INFO - 'sessionrestore', 22:45:55 INFO - 'sessionrestore_many_windows', 22:45:55 INFO - 'sessionrestore_no_auto_restore', 22:45:55 INFO - 'tabpaint']}, 22:45:55 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 22:45:55 INFO - 'tests': ['a11yr', 22:45:55 INFO - 'ts_paint', 22:45:55 INFO - 'tpaint', 22:45:55 INFO - 'sessionrestore', 22:45:55 INFO - 'sessionrestore_many_windows', 22:45:55 INFO - 'sessionrestore_no_auto_restore', 22:45:55 INFO - 'tabpaint']}, 22:45:55 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 22:45:55 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 22:45:55 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 22:45:55 INFO - 'tests': ['bloom_basic_singleton']}, 22:45:55 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 22:45:55 INFO - 'tests': ['bloom_basic']}, 22:45:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:45:55 INFO - 'tsvgr_opacity', 22:45:55 INFO - 'tart', 22:45:55 INFO - 'tscrollx', 22:45:55 INFO - 'tsvg_static']}, 22:45:55 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 22:45:55 INFO - 'tests': ['tsvgx', 22:45:55 INFO - 'tsvgr_opacity', 22:45:55 INFO - 'tart', 22:45:55 INFO - 'tscrollx', 22:45:55 INFO - 'tsvg_static']}, 22:45:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 22:45:55 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 22:45:55 INFO - 'talos_options': ['--disable-stylo'], 22:45:55 INFO - 'tests': ['tp5o']}, 22:45:55 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 22:45:55 INFO - 'talos_options': ['--mitmproxy', 22:45:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 22:45:55 INFO - '--firstNonBlankPaint'], 22:45:55 INFO - 'tests': ['tp6_google', 22:45:55 INFO - 'tp6_youtube', 22:45:55 INFO - 'tp6_amazon', 22:45:55 INFO - 'tp6_facebook']}, 22:45:55 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 22:45:55 INFO - 'talos_options': ['--disable-stylo', 22:45:55 INFO - '--mitmproxy', 22:45:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 22:45:55 INFO - '--firstNonBlankPaint'], 22:45:55 INFO - 'tests': ['tp6_google', 22:45:55 INFO - 'tp6_youtube', 22:45:55 INFO - 'tp6_amazon', 22:45:55 INFO - 'tp6_facebook']}, 22:45:55 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 22:45:55 INFO - 'talos_options': ['--stylo-threads=1', 22:45:55 INFO - '--mitmproxy', 22:45:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 22:45:55 INFO - '--firstNonBlankPaint'], 22:45:55 INFO - 'tests': ['tp6_google', 22:45:55 INFO - 'tp6_youtube', 22:45:55 INFO - 'tp6_amazon', 22:45:55 INFO - 'tp6_facebook']}, 22:45:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 22:45:55 INFO - 'talos_options': ['--xperf_path', 22:45:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:45:55 INFO - 'tests': ['tp5n']}, 22:45:55 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 22:45:55 INFO - 'talos_options': ['--disable-stylo', 22:45:55 INFO - '--xperf_path', 22:45:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:45:55 INFO - 'tests': ['tp5n']}}} 22:45:55 INFO - Running post-action listener: _resource_record_post_action 22:45:55 INFO - [mozharness: 2017-09-14 05:45:55.725624Z] Finished populate-webroot step (success) 22:45:55 INFO - [mozharness: 2017-09-14 05:45:55.725731Z] Running create-virtualenv step. 22:45:55 INFO - Running pre-action listener: _resource_record_pre_action 22:45:55 INFO - Running main action method: create_virtualenv 22:45:55 INFO - Creating virtualenv /builds/slave/test/build/venv 22:45:55 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 22:45:55 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 22:45:55 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 22:45:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:45:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:45:56 INFO - Installing distribute.............................................................................................................................................................................................done. 22:45:56 INFO - Installing pip...............done. 22:45:56 INFO - Return code: 0 22:45:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:45:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:45:56 INFO - Reading from file tmpfile_stdout 22:45:56 INFO - Output received: 22:45:56 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 22:45:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:45:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:45:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:45:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:45:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec5090>, '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 0xec5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebff90>, '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': 'dac658600622fd96716c9acf000001b3-1505365421.901742-1376979000', '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 22:45:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:45:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:45:56 INFO - Using env: {'DISPLAY': ':0', 22:45:56 INFO - 'HOME': '/home/cltbld', 22:45:56 INFO - 'LANG': 'en_US.UTF-8', 22:45:56 INFO - 'LANGUAGE': 'en_US:en', 22:45:56 INFO - 'LOGNAME': 'cltbld', 22:45:56 INFO - 'MAIL': '/var/mail/cltbld', 22:45:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:45:56 INFO - 'MOZ_NO_REMOTE': '1', 22:45:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:45:56 INFO - 'NO_EM_RESTART': '1', 22:45:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:45:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:45:56 INFO - 'PWD': '/builds/slave/test', 22:45:56 INFO - 'SHELL': '/bin/bash', 22:45:56 INFO - 'SHLVL': '1', 22:45:56 INFO - 'TERM': 'linux', 22:45:56 INFO - 'TMOUT': '86400', 22:45:56 INFO - 'USER': 'cltbld', 22:45:56 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1505365421.901742-1376979000', 22:45:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:45:56 INFO - '_': '/tools/buildbot/bin/python'} 22:45:57 INFO - Ignoring indexes: http://pypi.python.org/simple/ 22:45:57 INFO - Downloading/unpacking pip>=1.5 22:45:57 INFO - Running setup.py egg_info for package pip 22:45:57 INFO - warning: no files found matching 'pip/cacert.pem' 22:45:57 INFO - warning: no files found matching '*.html' under directory 'docs' 22:45:57 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 22:45:57 INFO - no previously-included directories found matching 'docs/_build/_sources' 22:45:57 INFO - Installing collected packages: pip 22:45:57 INFO - Found existing installation: pip 1.1 22:45:57 INFO - Uninstalling pip: 22:45:57 INFO - Successfully uninstalled pip 22:45:57 INFO - Running setup.py install for pip 22:45:57 INFO - warning: no files found matching 'pip/cacert.pem' 22:45:57 INFO - warning: no files found matching '*.html' under directory 'docs' 22:45:57 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 22:45:57 INFO - no previously-included directories found matching 'docs/_build/_sources' 22:45:57 INFO - Installing pip script to /builds/slave/test/build/venv/bin 22:45:57 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 22:45:57 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 22:45:57 INFO - Successfully installed pip 22:45:57 INFO - Cleaning up... 22:45:57 INFO - Return code: 0 22:45:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:45: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')]} 22:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:45: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')]} 22:45:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46: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 0xb551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec5090>, '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 0xec5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebff90>, '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': 'dac658600622fd96716c9acf000001b3-1505365421.901742-1376979000', '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 22:46: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 22:46: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 22:46:02 INFO - Using env: {'DISPLAY': ':0', 22:46:02 INFO - 'HOME': '/home/cltbld', 22:46:02 INFO - 'LANG': 'en_US.UTF-8', 22:46:02 INFO - 'LANGUAGE': 'en_US:en', 22:46:02 INFO - 'LOGNAME': 'cltbld', 22:46:02 INFO - 'MAIL': '/var/mail/cltbld', 22:46:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:02 INFO - 'MOZ_NO_REMOTE': '1', 22:46:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:46:02 INFO - 'NO_EM_RESTART': '1', 22:46:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:46:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:46:02 INFO - 'PWD': '/builds/slave/test', 22:46:02 INFO - 'SHELL': '/bin/bash', 22:46:02 INFO - 'SHLVL': '1', 22:46:02 INFO - 'TERM': 'linux', 22:46:02 INFO - 'TMOUT': '86400', 22:46:02 INFO - 'USER': 'cltbld', 22:46:02 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1505365421.901742-1376979000', 22:46:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:02 INFO - '_': '/tools/buildbot/bin/python'} 22:46:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:03 INFO - Downloading/unpacking psutil>=3.1.1 22:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:46:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:46:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:46:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:46:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:46:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:46:04 INFO - Installing collected packages: psutil 22:46:04 INFO - Running setup.py install for psutil 22:46:04 INFO - building 'psutil._psutil_linux' extension 22:46:04 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 22:46: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 22:46:05 INFO - building 'psutil._psutil_posix' extension 22:46: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 22:46: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 22:46:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:46:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:46:05 INFO - Successfully installed psutil 22:46:05 INFO - Cleaning up... 22:46:05 INFO - Return code: 0 22:46:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:46: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')]} 22:46:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46: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')]} 22:46:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46: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 0xb551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec5090>, '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 0xec5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebff90>, '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': 'dac658600622fd96716c9acf000001b3-1505365421.901742-1376979000', '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 22:46: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 22:46: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 22:46:05 INFO - Using env: {'DISPLAY': ':0', 22:46:05 INFO - 'HOME': '/home/cltbld', 22:46:05 INFO - 'LANG': 'en_US.UTF-8', 22:46:05 INFO - 'LANGUAGE': 'en_US:en', 22:46:05 INFO - 'LOGNAME': 'cltbld', 22:46:05 INFO - 'MAIL': '/var/mail/cltbld', 22:46:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:05 INFO - 'MOZ_NO_REMOTE': '1', 22:46:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:46:05 INFO - 'NO_EM_RESTART': '1', 22:46:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:46:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:46:05 INFO - 'PWD': '/builds/slave/test', 22:46:05 INFO - 'SHELL': '/bin/bash', 22:46:05 INFO - 'SHLVL': '1', 22:46:05 INFO - 'TERM': 'linux', 22:46:05 INFO - 'TMOUT': '86400', 22:46:05 INFO - 'USER': 'cltbld', 22:46:05 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1505365421.901742-1376979000', 22:46:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:05 INFO - '_': '/tools/buildbot/bin/python'} 22:46:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:46: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 22:46: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 22:46: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 22:46: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 22:46:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:46:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:46:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:46:06 INFO - Installing collected packages: mozsystemmonitor 22:46:06 INFO - Running setup.py install for mozsystemmonitor 22:46:06 INFO - Successfully installed mozsystemmonitor 22:46:06 INFO - Cleaning up... 22:46:06 INFO - Return code: 0 22:46:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:46:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:46:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:46:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xb551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec5090>, '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 0xec5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebff90>, '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': 'dac658600622fd96716c9acf000001b3-1505365421.901742-1376979000', '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 22:46:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 22:46:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 22:46:06 INFO - Using env: {'DISPLAY': ':0', 22:46:06 INFO - 'HOME': '/home/cltbld', 22:46:06 INFO - 'LANG': 'en_US.UTF-8', 22:46:06 INFO - 'LANGUAGE': 'en_US:en', 22:46:06 INFO - 'LOGNAME': 'cltbld', 22:46:06 INFO - 'MAIL': '/var/mail/cltbld', 22:46:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:06 INFO - 'MOZ_NO_REMOTE': '1', 22:46:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:46:06 INFO - 'NO_EM_RESTART': '1', 22:46:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:46:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:46:06 INFO - 'PWD': '/builds/slave/test', 22:46:06 INFO - 'SHELL': '/bin/bash', 22:46:06 INFO - 'SHLVL': '1', 22:46:06 INFO - 'TERM': 'linux', 22:46:06 INFO - 'TMOUT': '86400', 22:46:06 INFO - 'USER': 'cltbld', 22:46:06 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1505365421.901742-1376979000', 22:46:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:06 INFO - '_': '/tools/buildbot/bin/python'} 22:46:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:07 INFO - Downloading/unpacking jsonschema==2.5.1 22:46: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 22:46: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 22:46: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 22:46: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 22:46:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:46:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:46: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 22:46: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 22:46: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 22:46: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 22:46:08 INFO - Downloading functools32-3.2.3-2.tar.gz 22:46:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:46:08 INFO - warning: no files found matching '*.txt' 22:46:08 INFO - no previously-included directories found matching 'build' 22:46:08 INFO - no previously-included directories found matching 'dist' 22:46:08 INFO - no previously-included directories found matching '.git*' 22:46:08 INFO - Installing collected packages: jsonschema, functools32 22:46:08 INFO - Running setup.py install for functools32 22:46:08 INFO - warning: no files found matching '*.txt' 22:46:08 INFO - no previously-included directories found matching 'build' 22:46:08 INFO - no previously-included directories found matching 'dist' 22:46:08 INFO - no previously-included directories found matching '.git*' 22:46:08 INFO - Successfully installed jsonschema functools32 22:46:08 INFO - Cleaning up... 22:46:08 INFO - Return code: 0 22:46:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:46: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')]} 22:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46: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')]} 22:46:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46: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 0xb551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec5090>, '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 0xec5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebff90>, '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': 'dac658600622fd96716c9acf000001b3-1505365421.901742-1376979000', '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 22:46: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 22:46: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 22:46:08 INFO - Using env: {'DISPLAY': ':0', 22:46:08 INFO - 'HOME': '/home/cltbld', 22:46:08 INFO - 'LANG': 'en_US.UTF-8', 22:46:08 INFO - 'LANGUAGE': 'en_US:en', 22:46:08 INFO - 'LOGNAME': 'cltbld', 22:46:08 INFO - 'MAIL': '/var/mail/cltbld', 22:46:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:08 INFO - 'MOZ_NO_REMOTE': '1', 22:46:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:46:08 INFO - 'NO_EM_RESTART': '1', 22:46:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:46:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:46:08 INFO - 'PWD': '/builds/slave/test', 22:46:08 INFO - 'SHELL': '/bin/bash', 22:46:08 INFO - 'SHLVL': '1', 22:46:08 INFO - 'TERM': 'linux', 22:46:08 INFO - 'TMOUT': '86400', 22:46:08 INFO - 'USER': 'cltbld', 22:46:08 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1505365421.901742-1376979000', 22:46:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:08 INFO - '_': '/tools/buildbot/bin/python'} 22:46:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:46:08 INFO - Cleaning up... 22:46:08 INFO - Return code: 0 22:46:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:46: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')]} 22:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46: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')]} 22:46:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46: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', '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 0xb551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec5090>, '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 0xec5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebff90>, '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': 'dac658600622fd96716c9acf000001b3-1505365421.901742-1376979000', '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 22:46: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:46: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 blobuploader==1.2.4 22:46:08 INFO - Using env: {'DISPLAY': ':0', 22:46:08 INFO - 'HOME': '/home/cltbld', 22:46:08 INFO - 'LANG': 'en_US.UTF-8', 22:46:08 INFO - 'LANGUAGE': 'en_US:en', 22:46:08 INFO - 'LOGNAME': 'cltbld', 22:46:08 INFO - 'MAIL': '/var/mail/cltbld', 22:46:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:08 INFO - 'MOZ_NO_REMOTE': '1', 22:46:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:46:08 INFO - 'NO_EM_RESTART': '1', 22:46:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:46:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:46:08 INFO - 'PWD': '/builds/slave/test', 22:46:08 INFO - 'SHELL': '/bin/bash', 22:46:08 INFO - 'SHLVL': '1', 22:46:08 INFO - 'TERM': 'linux', 22:46:08 INFO - 'TMOUT': '86400', 22:46:08 INFO - 'USER': 'cltbld', 22:46:08 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1505365421.901742-1376979000', 22:46:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:08 INFO - '_': '/tools/buildbot/bin/python'} 22:46:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:09 INFO - Downloading/unpacking blobuploader==1.2.4 22:46: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 22:46: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 22:46: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 22:46: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 22:46:10 INFO - Downloading blobuploader-1.2.4.tar.gz 22:46:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:46:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:46: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 22:46: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 22:46: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 22:46: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 22:46:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:46:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:46: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 22:46: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 22:46: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 22:46: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 22:46:10 INFO - Downloading docopt-0.6.1.tar.gz 22:46:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:46:10 INFO - Installing collected packages: blobuploader, requests, docopt 22:46:10 INFO - Running setup.py install for blobuploader 22:46:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:46:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:46:10 INFO - Running setup.py install for requests 22:46:11 INFO - Running setup.py install for docopt 22:46:11 INFO - Successfully installed blobuploader requests docopt 22:46:11 INFO - Cleaning up... 22:46:11 INFO - Return code: 0 22:46:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:46: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')]} 22:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46: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')]} 22:46:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46: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 0xb551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec5090>, '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 0xec5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebff90>, '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': 'dac658600622fd96716c9acf000001b3-1505365421.901742-1376979000', '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 22:46: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 22:46: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 22:46:11 INFO - Using env: {'DISPLAY': ':0', 22:46:11 INFO - 'HOME': '/home/cltbld', 22:46:11 INFO - 'LANG': 'en_US.UTF-8', 22:46:11 INFO - 'LANGUAGE': 'en_US:en', 22:46:11 INFO - 'LOGNAME': 'cltbld', 22:46:11 INFO - 'MAIL': '/var/mail/cltbld', 22:46:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:11 INFO - 'MOZ_NO_REMOTE': '1', 22:46:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:46:11 INFO - 'NO_EM_RESTART': '1', 22:46:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:46:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:46:11 INFO - 'PWD': '/builds/slave/test', 22:46:11 INFO - 'SHELL': '/bin/bash', 22:46:11 INFO - 'SHLVL': '1', 22:46:11 INFO - 'TERM': 'linux', 22:46:11 INFO - 'TMOUT': '86400', 22:46:11 INFO - 'USER': 'cltbld', 22:46:11 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1505365421.901742-1376979000', 22:46:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:11 INFO - '_': '/tools/buildbot/bin/python'} 22:46:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:46:11 INFO - Running setup.py (path:/tmp/pip-Yeqs0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:46:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:46:11 INFO - Running setup.py (path:/tmp/pip-bPUWR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:46:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:46:11 INFO - Running setup.py (path:/tmp/pip-rrZ1cp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:46:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:46:11 INFO - Running setup.py (path:/tmp/pip-6jopG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:46:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:46:11 INFO - Running setup.py (path:/tmp/pip-PqfAqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:46:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:46:11 INFO - Running setup.py (path:/tmp/pip-zIyDLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:46:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:46:11 INFO - Running setup.py (path:/tmp/pip-qThIWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:46:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:46:11 INFO - Running setup.py (path:/tmp/pip-1lkqVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:46:12 INFO - Running setup.py (path:/tmp/pip-WVLBGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:46:12 INFO - Running setup.py (path:/tmp/pip-xn6lL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:46:12 INFO - Running setup.py (path:/tmp/pip-aLo3TK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:46:12 INFO - Running setup.py (path:/tmp/pip-ooG6cH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:46:12 INFO - Running setup.py (path:/tmp/pip-bJM_ce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:46:12 INFO - Running setup.py (path:/tmp/pip-pXAqhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:46:12 INFO - Running setup.py (path:/tmp/pip-OKOM5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:46:12 INFO - Running setup.py (path:/tmp/pip-00L7W5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:46:12 INFO - Running setup.py (path:/tmp/pip-qYgfZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:46:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:46:12 INFO - Running setup.py install for manifestparser 22:46:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:46:12 INFO - Running setup.py install for mozcrash 22:46:12 INFO - Running setup.py install for mozdebug 22:46:12 INFO - Running setup.py install for mozdevice 22:46:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:46:13 INFO - Running setup.py install for mozfile 22:46:13 INFO - Running setup.py install for mozhttpd 22:46:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:46:13 INFO - Running setup.py install for mozinfo 22:46:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:46:13 INFO - Running setup.py install for mozInstall 22:46:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:46:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:46:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:46:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:46:13 INFO - Running setup.py install for mozleak 22:46:13 INFO - Running setup.py install for mozlog 22:46:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:46:13 INFO - Running setup.py install for moznetwork 22:46:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:46:13 INFO - Running setup.py install for mozprocess 22:46:13 INFO - Running setup.py install for mozprofile 22:46:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:46:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:46:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:46:14 INFO - Running setup.py install for mozrunner 22:46:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:46:14 INFO - Running setup.py install for mozscreenshot 22:46:14 INFO - Running setup.py install for moztest 22:46:14 INFO - Running setup.py install for mozversion 22:46:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:46:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:46:14 INFO - Cleaning up... 22:46:14 INFO - Return code: 0 22:46:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:46: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')]} 22:46:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46: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')]} 22:46:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46: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 0xb551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec5090>, '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 0xec5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebff90>, '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': 'dac658600622fd96716c9acf000001b3-1505365421.901742-1376979000', '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 22:46: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 22:46: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 22:46:14 INFO - Using env: {'DISPLAY': ':0', 22:46:14 INFO - 'HOME': '/home/cltbld', 22:46:14 INFO - 'LANG': 'en_US.UTF-8', 22:46:14 INFO - 'LANGUAGE': 'en_US:en', 22:46:14 INFO - 'LOGNAME': 'cltbld', 22:46:14 INFO - 'MAIL': '/var/mail/cltbld', 22:46:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:14 INFO - 'MOZ_NO_REMOTE': '1', 22:46:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:46:14 INFO - 'NO_EM_RESTART': '1', 22:46:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:46:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:46:14 INFO - 'PWD': '/builds/slave/test', 22:46:14 INFO - 'SHELL': '/bin/bash', 22:46:14 INFO - 'SHLVL': '1', 22:46:14 INFO - 'TERM': 'linux', 22:46:14 INFO - 'TMOUT': '86400', 22:46:14 INFO - 'USER': 'cltbld', 22:46:14 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1505365421.901742-1376979000', 22:46:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:14 INFO - '_': '/tools/buildbot/bin/python'} 22:46:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:46:14 INFO - Running setup.py (path:/tmp/pip-1CEJjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:46:14 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)) 22:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:46:14 INFO - Running setup.py (path:/tmp/pip-myCd3X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:46:14 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)) 22:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:46:14 INFO - Running setup.py (path:/tmp/pip-Mjvl_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:46:14 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)) 22:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:46:14 INFO - Running setup.py (path:/tmp/pip-8419jS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:46:14 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)) 22:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:46:14 INFO - Running setup.py (path:/tmp/pip-BBEp1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:46: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)) 22:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:46:15 INFO - Running setup.py (path:/tmp/pip-dDDTan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:46: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)) 22:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:46:15 INFO - Running setup.py (path:/tmp/pip-G1vUkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:46: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)) 22:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:46:15 INFO - Running setup.py (path:/tmp/pip-N9TAeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:46: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)) 22:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:46:15 INFO - Running setup.py (path:/tmp/pip-gpjdC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:46: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)) 22:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:46:15 INFO - Running setup.py (path:/tmp/pip-oefNvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:46: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)) 22:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:46:15 INFO - Running setup.py (path:/tmp/pip-VBorNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:46: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)) 22:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:46:15 INFO - Running setup.py (path:/tmp/pip-2VBydn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:46: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)) 22:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:46:15 INFO - Running setup.py (path:/tmp/pip-pJPOK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:46: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)) 22:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:46:15 INFO - Running setup.py (path:/tmp/pip-WZzHGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:46:15 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)) 22:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:46:15 INFO - Running setup.py (path:/tmp/pip-gKuFvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:46:15 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)) 22:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:46:15 INFO - Running setup.py (path:/tmp/pip-dkTgVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:46:15 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)) 22:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:46:15 INFO - Running setup.py (path:/tmp/pip-_LhvJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:46:15 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)) 22:46:15 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)) 22:46:15 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)) 22:46:15 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)) 22:46:15 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)) 22:46:15 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)) 22:46:15 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)) 22:46:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:46:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:46:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:46:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:46:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:46:16 INFO - Downloading blessings-1.6.tar.gz 22:46:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:46:17 INFO - Installing collected packages: blessings 22:46:17 INFO - Running setup.py install for blessings 22:46:17 INFO - Successfully installed blessings 22:46:17 INFO - Cleaning up... 22:46:17 INFO - Return code: 0 22:46:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:46:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:46:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:46:17 INFO - Reading from file tmpfile_stdout 22:46:17 INFO - Current package versions: 22:46:17 INFO - argparse == 1.2.1 22:46:17 INFO - blessings == 1.6 22:46:17 INFO - blobuploader == 1.2.4 22:46:17 INFO - docopt == 0.6.1 22:46:17 INFO - functools32 == 3.2.3-2 22:46:17 INFO - jsonschema == 2.5.1 22:46:17 INFO - manifestparser == 1.1 22:46:17 INFO - mozInstall == 1.13 22:46:17 INFO - mozcrash == 1.0 22:46:17 INFO - mozdebug == 0.1 22:46:17 INFO - mozdevice == 0.51 22:46:17 INFO - mozfile == 1.2 22:46:17 INFO - mozhttpd == 0.7 22:46:17 INFO - mozinfo == 0.10 22:46:17 INFO - mozleak == 0.1 22:46:17 INFO - mozlog == 3.5 22:46:17 INFO - moznetwork == 0.27 22:46:17 INFO - mozprocess == 0.25 22:46:17 INFO - mozprofile == 0.28 22:46:17 INFO - mozrunner == 6.13 22:46:17 INFO - mozscreenshot == 0.1 22:46:17 INFO - mozsystemmonitor == 0.3 22:46:17 INFO - moztest == 0.8 22:46:17 INFO - mozversion == 1.4 22:46:17 INFO - psutil == 3.1.1 22:46:17 INFO - requests == 1.2.3 22:46:17 INFO - wsgiref == 0.1.2 22:46:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:46: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')]} 22:46:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46: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')]} 22:46:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46: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 0xb551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec5090>, '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 0xec5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebff90>, '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': 'dac658600622fd96716c9acf000001b3-1505365421.901742-1376979000', '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 22:46: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 22:46: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 22:46:17 INFO - Using env: {'DISPLAY': ':0', 22:46:17 INFO - 'HOME': '/home/cltbld', 22:46:17 INFO - 'LANG': 'en_US.UTF-8', 22:46:17 INFO - 'LANGUAGE': 'en_US:en', 22:46:17 INFO - 'LOGNAME': 'cltbld', 22:46:17 INFO - 'MAIL': '/var/mail/cltbld', 22:46:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:17 INFO - 'MOZ_NO_REMOTE': '1', 22:46:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:46:17 INFO - 'NO_EM_RESTART': '1', 22:46:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:46:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:46:17 INFO - 'PWD': '/builds/slave/test', 22:46:17 INFO - 'SHELL': '/bin/bash', 22:46:17 INFO - 'SHLVL': '1', 22:46:17 INFO - 'TERM': 'linux', 22:46:17 INFO - 'TMOUT': '86400', 22:46:17 INFO - 'USER': 'cltbld', 22:46:17 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1505365421.901742-1376979000', 22:46:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:17 INFO - '_': '/tools/buildbot/bin/python'} 22:46:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:17 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)) 22:46:17 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)) 22:46:17 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)) 22:46:17 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)) 22:46:17 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)) 22:46:17 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)) 22:46:17 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)) 22:46:17 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)) 22:46:17 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)) 22:46:17 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 22:46:17 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 22:46:17 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 22:46:17 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 22:46:17 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 22:46:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 22:46:18 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)) 22:46:18 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)) 22:46:18 INFO - Installing collected packages: simplejson 22:46:18 INFO - Running setup.py install for simplejson 22:46:18 INFO - building 'simplejson._speedups' extension 22:46:18 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 22:46:19 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 22:46:19 INFO - Successfully installed simplejson 22:46:19 INFO - Cleaning up... 22:46:19 INFO - Return code: 0 22:46:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:46:19 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')]} 22:46:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46:19 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')]} 22:46:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46:19 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 0xb551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec5090>, '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 0xec5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebff90>, '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': 'dac658600622fd96716c9acf000001b3-1505365421.901742-1376979000', '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 22:46:19 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 22:46:19 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 22:46:19 INFO - Using env: {'DISPLAY': ':0', 22:46:19 INFO - 'HOME': '/home/cltbld', 22:46:19 INFO - 'LANG': 'en_US.UTF-8', 22:46:19 INFO - 'LANGUAGE': 'en_US:en', 22:46:19 INFO - 'LOGNAME': 'cltbld', 22:46:19 INFO - 'MAIL': '/var/mail/cltbld', 22:46:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:19 INFO - 'MOZ_NO_REMOTE': '1', 22:46:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:46:19 INFO - 'NO_EM_RESTART': '1', 22:46:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:46:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:46:19 INFO - 'PWD': '/builds/slave/test', 22:46:19 INFO - 'SHELL': '/bin/bash', 22:46:19 INFO - 'SHLVL': '1', 22:46:19 INFO - 'TERM': 'linux', 22:46:19 INFO - 'TMOUT': '86400', 22:46:19 INFO - 'USER': 'cltbld', 22:46:19 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1505365421.901742-1376979000', 22:46:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:19 INFO - '_': '/tools/buildbot/bin/python'} 22:46:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:46:20 INFO - Cleaning up... 22:46:20 INFO - Return code: 0 22:46:20 INFO - Running post-action listener: _resource_record_post_action 22:46:20 INFO - Running post-action listener: _start_resource_monitoring 22:46:20 INFO - Starting resource monitoring. 22:46:20 INFO - [mozharness: 2017-09-14 05:46:20.141860Z] Finished create-virtualenv step (success) 22:46:20 INFO - [mozharness: 2017-09-14 05:46:20.142369Z] Running install step. 22:46:20 INFO - Running pre-action listener: _resource_record_pre_action 22:46:20 INFO - Running main action method: install 22:46:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:46:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:46:20 INFO - Reading from file tmpfile_stdout 22:46:20 INFO - Detecting whether we're running mozinstall >=1.0... 22:46:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:46:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:46:20 INFO - Reading from file tmpfile_stdout 22:46:20 INFO - Output received: 22:46:20 INFO - Usage: mozinstall [options] installer 22:46:20 INFO - Options: 22:46:20 INFO - -h, --help show this help message and exit 22:46:20 INFO - -d DEST, --destination=DEST 22:46:20 INFO - Directory to install application into. [default: 22:46:20 INFO - "/builds/slave/test"] 22:46:20 INFO - --app=APP Application being installed. [default: firefox] 22:46:20 INFO - mkdir: /builds/slave/test/build/application 22:46: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'] 22:46:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 22:46:38 INFO - Reading from file tmpfile_stdout 22:46:38 INFO - Output received: 22:46:38 INFO - /builds/slave/test/build/application/firefox/firefox 22:46:38 INFO - Running post-action listener: _resource_record_post_action 22:46:38 INFO - [mozharness: 2017-09-14 05:46:38.230783Z] Finished install step (success) 22:46:38 INFO - [mozharness: 2017-09-14 05:46:38.231034Z] Running setup-mitmproxy step. 22:46:38 INFO - Running pre-action listener: _resource_record_pre_action 22:46:38 INFO - Running main action method: setup_mitmproxy 22:46:38 INFO - Skipping: mitmproxy is not required 22:46:38 INFO - Running post-action listener: _resource_record_post_action 22:46:38 INFO - [mozharness: 2017-09-14 05:46:38.232164Z] Finished setup-mitmproxy step (success) 22:46:38 INFO - [mozharness: 2017-09-14 05:46:38.232384Z] Running run-tests step. 22:46:38 INFO - Running pre-action listener: _resource_record_pre_action 22:46:38 INFO - Running pre-action listener: _set_gcov_prefix 22:46:38 INFO - Running main action method: run_tests 22:46:38 WARNING - Try message not found. 22:46:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:46:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:46:38 INFO - Python 2.7.3 22:46:38 INFO - Return code: 0 22:46:38 INFO - grabbing minidump binary from tooltool 22:46: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')]} 22:46: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 0xec5090>, '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 0xec5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xebff90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:46: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 22:46: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 22:46: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 22:46:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:46:38 INFO - Return code: 0 22:46:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:46:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:46:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:46:38 INFO - ENV: RUST_BACKTRACE is now full 22:46:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:46:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:46:38 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/XkYgQGM7RR6WsMLSikInwA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-078', '--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 22:46:38 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/XkYgQGM7RR6WsMLSikInwA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-078 --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 22:46:38 INFO - Using env: {'DISPLAY': ':0', 22:46:38 INFO - 'HOME': '/home/cltbld', 22:46:38 INFO - 'LANG': 'en_US.UTF-8', 22:46:38 INFO - 'LANGUAGE': 'en_US:en', 22:46:38 INFO - 'LOGNAME': 'cltbld', 22:46:38 INFO - 'MAIL': '/var/mail/cltbld', 22:46:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:46:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:46:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:38 INFO - 'MOZ_NO_REMOTE': '1', 22:46:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:46:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:46:38 INFO - 'NO_EM_RESTART': '1', 22:46:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:46:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:46:38 INFO - 'PWD': '/builds/slave/test', 22:46:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:46:38 INFO - 'RUST_BACKTRACE': 'full', 22:46:38 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 22:46:38 INFO - 'SHELL': '/bin/bash', 22:46:38 INFO - 'SHLVL': '1', 22:46:38 INFO - 'TERM': 'linux', 22:46:38 INFO - 'TMOUT': '86400', 22:46:38 INFO - 'USER': 'cltbld', 22:46:38 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1505365421.901742-1376979000', 22:46:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:38 INFO - '_': '/tools/buildbot/bin/python'} 22:46:38 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/XkYgQGM7RR6WsMLSikInwA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-078', '--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 22:46:38 INFO - mozversion application_buildid: 20170914045317 22:46:38 INFO - mozversion application_changeset: 6f08f91f8db00d385e5d564b0102bf0dece39f6f 22:46:38 INFO - mozversion application_display_name: Nightly 22:46:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:46:38 INFO - mozversion application_name: Firefox 22:46:38 INFO - mozversion application_remotingname: firefox 22:46:38 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:46:38 INFO - mozversion application_vendor: Mozilla 22:46:38 INFO - mozversion application_version: 57.0a1 22:46:38 INFO - mozversion platform_buildid: 20170914045317 22:46:38 INFO - mozversion platform_changeset: 6f08f91f8db00d385e5d564b0102bf0dece39f6f 22:46:38 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:46:38 INFO - mozversion platform_version: 57.0a1 22:46:38 INFO - using testdate: 1505367998 22:46:38 INFO - actual date: 1505367998 22:46:38 INFO - starting webserver on 'localhost:60338' 22:46:38 INFO - SUITE-START | Running 2 tests 22:46:38 INFO - TEST-START | dromaeo_css 22:46:38 INFO - Initialising browser for dromaeo_css test... 22:46:38 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60338/getInfo.html -profile /tmp/tmpMajHOZ/profile 22:46:38 INFO - TEST-INFO | started process 30848 (/builds/slave/test/build/application/firefox/firefox http://localhost:60338/getInfo.html) 22:46:44 INFO - TEST-INFO | 30848: exit 0 22:46:44 INFO - Browser initialized. 22:46:44 INFO - Running cycle 1/1 for dromaeo_css test... 22:46:44 INFO - Using env: {'DISPLAY': ':0', 22:46:44 INFO - 'HOME': '/home/cltbld', 22:46:44 INFO - 'JSGC_DISABLE_POISONING': '1', 22:46:44 INFO - 'LANG': 'en_US.UTF-8', 22:46:44 INFO - 'LANGUAGE': 'en_US:en', 22:46:44 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 22:46:44 INFO - 'LOGNAME': 'cltbld', 22:46:44 INFO - 'MAIL': '/var/mail/cltbld', 22:46:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:46:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:46:44 INFO - 'MOZ_CRASHREPORTER': '1', 22:46:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:44 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 22:46:44 INFO - 'MOZ_NO_REMOTE': '1', 22:46:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:46:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:46:44 INFO - 'NO_EM_RESTART': '1', 22:46:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:46:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:46:44 INFO - 'PWD': '/builds/slave/test', 22:46:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:46:44 INFO - 'RUST_BACKTRACE': 'full', 22:46:44 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 22:46:44 INFO - 'SHELL': '/bin/bash', 22:46:44 INFO - 'SHLVL': '1', 22:46:44 INFO - 'STYLO_FORCE_DISABLED': '1', 22:46:44 INFO - 'TERM': 'linux', 22:46:44 INFO - 'TMOUT': '86400', 22:46:44 INFO - 'USER': 'cltbld', 22:46:44 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1505365421.901742-1376979000', 22:46:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:44 INFO - '_': '/tools/buildbot/bin/python'} 22:46:44 INFO - TEST-INFO | started process 31082 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMajHOZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 22:46:45 INFO - PID 31082 | 22:46:45 INFO - PID 31082 | (/builds/slave/test/build/application/firefox/firefox:31132): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 22:46:45 INFO - PID 31082 | 22:46:55 INFO - PID 31082 | RSS: Main: 173363200 22:46:55 INFO - PID 31082 | 22:49:52 INFO - PID 31082 | Cycle 1(1): loaded http://localhost:60338/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60338/tests/dromaeo/cssquery-ext.html) 22:49:53 INFO - PID 31082 | RSS: Main: 176590848 22:49:53 INFO - PID 31082 | 22:52:54 INFO - PID 31082 | Cycle 1(1): loaded http://localhost:60338/tests/dromaeo/cssquery-ext.html (next: http://localhost:60338/tests/dromaeo/cssquery-jquery.html) 22:52:55 INFO - PID 31082 | RSS: Main: 170676224 22:52:55 INFO - PID 31082 | 22:55:57 INFO - PID 31082 | Cycle 1(1): loaded http://localhost:60338/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60338/tests/dromaeo/cssquery-mootools.html) 22:55:57 INFO - PID 31082 | RSS: Main: 175017984 22:55:57 INFO - PID 31082 | 22:58:59 INFO - PID 31082 | Cycle 1(1): loaded http://localhost:60338/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60338/tests/dromaeo/cssquery-prototype.html) 22:59:00 INFO - PID 31082 | RSS: Main: 173187072 22:59:00 INFO - PID 31082 | 23:02:03 INFO - PID 31082 | Cycle 1(1): loaded http://localhost:60338/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60338/tests/dromaeo/cssquery-yui.html) 23:02:03 INFO - PID 31082 | RSS: Main: 174202880 23:02:03 INFO - PID 31082 | 23:05:05 INFO - PID 31082 | Cycle 1(1): loaded http://localhost:60338/tests/dromaeo/cssquery-yui.html (next: http://localhost:60338/tests/dromaeo/cssquery-dojo.html) 23:05:05 INFO - PID 31082 | RSS: Main: 177451008 23:05:05 INFO - PID 31082 | 23:05:05 INFO - PID 31082 | __start_tp_report 23:05:05 INFO - PID 31082 | _x_x_mozilla_page_load 23:05:05 INFO - PID 31082 | _x_x_mozilla_page_load_details 23:05:05 INFO - PID 31082 | |i|pagename|runs| 23:05:05 INFO - PID 31082 | |0;dojo.html;3140.6702296258877;3145.2451411661204;3152.306492571635;3160.9884836852216;3166.588343515343;6177.104319873616;6195.2255968004;6195.6902154892305;6262.373762623735;6315.905261421077;6285.277193122793;6302.306746257908;6309.747610095591;6310.779122730705;6324.430801227889;5800.390958949291;5860.296764388258;5871.706414679249;5877.911831322523;5910.0543912973935;12.00867417255348;5806.59353845231;5901.822945311626;5904.3800400957925;5913.793017244398;5427.674339539621;5720.227769251161;5731.885362292752;5829.708514574297;5833.32916714579;5777.220075289866;5788.160716696056;5855.297364316267;5868.2664666916635;5892.705364731746;5750.367459579485;5773.162891380726;5840;5841.386654401269;5849.210356601847;6190.350013248634;6265.342139075377;6297.527685423612;6382.266039405481;6412.230532336102;6594.670266486656;6750.594964302158;6794.175007177311;6865.41643960264;6899.206591242021;6706.932930670729;6761.628110453923;6780.254172041072;6789.558678685919;6798.626075565842;6212.099245609361;6275.7489700411925;6308.716107775161;6333.398327158959;6383.265924418705;6888.380045795902;6981.0924579804305;6987.161540615159;6991.230964593839;6993.195782484978;6565.310642382577;6566.277709451956;6635;6644.66776661165;6670.266270710218;6624.56940298879;6690.698918548677;6692.933070669231;6709.127813384326;6711.496637752188;6731.528792984542;6758.425533829582;6806.115205023315;6806.591604503746;6830.385265326046;6771.8984215236815;6781.6609169541325;6842.213145488333;6863.622500762506;6863.622500762506;5251.501107394792;5257.395399529103;5353.38436079848;5422.267993820784;5427.45725427462;4610.907781844411;4635.397398338195;4651.325557794101;4671.976640116778;4765.761711914391;5820.447057529528;5824.068149096124;5882.676452795052;5883.235179426732;5886.58793884424;6739.59562426256;6843.692033858489;6912.377885990184;6912.930870691329;6921.965390173118;5810.041343178413;5812.564057695605;5875.794347197828;5894.263217097863;5906;5728.598998070179;5804.390538993345;5822.679752613647;5823.854403639858;5833.620814647034;6513.218413790375;6615.305392933769;6661;6678.666066696743;6684.699188536528;6761.8647627047185;6852.349026842442;6852.794416167523;6943.89584156238;6955.617441040791;6376.872462550816;6571.441427478527;6573.704183311666;6664.033715111379;6666.933330666825;6660.933390666031;6727.966360168168;6761.154855643044;6801.387875091265;6817.7272909083085;6840;6845.5550389224545;6915.688794004182;6917.9308206917285;6919;6635.137432133792;6640.701168447335;6717.697703603252;6727.831804204739;6740.359665831738;6493.7727179550375;6559.934400655932;6599;6611.570247933869;6707.5975441473665;6572.934270657232;6604.240512341143;6604.438622717123;6616.4045235929;6622.139121914313;6582.868342633216;6645.534812563074;6716.764913228014;6717.630530320879;6765.661716914233;6229.5327850410495;6464.612123272619;6472.805815825533;6543.770968016287;6565.113709649137 23:05:05 INFO - PID 31082 | |1;ext.html;811.7037281392294;832.2301870769538;858.1075681291458;860.8665656823187;872.4721543466203;41782.79108604456;42778.57221427785;42850.571494285046;42862;42892.78553607231;39561.40657890134;39837.203255934866;39906.8004659977;43241.13517729643;43987.56012439875;7877.6848926042885;7970.920290797105;7972.720954766584;7976.800579985489;7989.520628762264;7812.960935195316;7928.088269848955;7937.841243175133;7941.483803552751;7946.404019698517;7982.082060563022;8000.159983201767;8009;8022.237887400687;8023.67905283788;7917.802054948615;7955.204479552028;7971.123176450586;7972.24263694951;7977.680892764282;7775.105862825791;7837.412194085409;7841.333486653642;7843.921560784376;7847.215278472164;38981.415278770844;39062.80468597667;39105.60894391077;39130.413043804365;39248.41127383091;3561.6438356164435;3594.748367614268;3596.5504311961004;3601.135727425399;3605.693516051139;32118.518222226685;32152;32183.195420114684;32285.35429291401;32303;5095.133827249377;5251.212318152269;5292.470752924715;5301.5758739301145;5332.280142180794;185407;189375;189772;193055.0347248269;193496;49817.25274120891;50733.74633126885;50805.491945080816;50807;50849;52189.21716174261;52391;52440.21339679908;52442;52485.47514524882;16452.917735411247;16593.91703041477;16618.25217865199;16619.335226591043;16633;13578.456861725617;13586.592402227949;13590.25253611041;13599.320033998261;13608.93195534016;13389.129706569041;13420;13452.798208026887;13464.596062118153;13611.727765444833;5050.823221187241;5089.872753181126;5130.666506677054;5155.690658560498;5214.45248248936;999.4802702594756;1000.3597697473623;1011.691434112588;1021.5913634546092;1023.7184774187158;23063.654045189334;23168.768312317;23226.287903285785;23256.3023109307;23390.64914026291;1082.8484012238293;1109.8335249712445;1110.7056629993058;1111.3332000799455;1119.9888001120048;12315.076369272341;12347.876521234673;12384.56654017105;12400.6279811604;12443.688907777378;223150;230043;238401;239581;239770;53793;53853;54086.91826163455;54145.72927135339;54229.45770542323;1446.2479510654612;1452.978205326921;1462.4881291548086;1472.9116253024854;1479.8890083243584;22447.326580201967;22996;23106.884465577565;23144.3056708299;23315.533689326458;38580.228395432496;38614.2277154461;38624.80687596544;38688.80655596704;38744.61255387523;199004;199745;199960;200050;200079;35078.64921350856;35530.822345888104;36095.27809443744;36145.45781813222;36187.638123618424;44015.11969760523;45224.773876130406;45423.54576454193;45545.31682024839;45726.77136614296;33087.338253235284;33120.66879331176;33124.33751325008;33131.50302745413;33842.49236261409;32569.18577035593;32612.673873260963;32744.34511309713;32980.50529242111;33606.49590256099;35553.82223088868;36784.632153679195;36886.44670330001;36939;37129.81435092807;31846.68153318437;32477.35045299128;32698.673013270516;32722.181945451553;33193.336133277684;23563.267117856154;23781.405464863517;23831.04675812948;23942.565780939687;24243.87878060669 23:05:05 INFO - PID 31082 | |2;jquery.html;572.436150391864;582.18203424189;583.422411812306;589.2457654202622;590.630855715178;22067.779322206774;22577.54844903101;22714.091436342547;22736.65895011572;22744.54510909781;23383.181588644402;24265.51468970624;24569.75430245697;24684.259472215817;24776.75223247767;6299.149614801989;6475.996220585816;6480.351964803505;6482.902756458657;6483.059956306332;6339.080833279172;6377.808665740035;6461.8707625847455;6464.644444555547;6466.708998095073;6573.967130164342;6589.967050164766;6592.967035164841;6594.439472644831;6594.472442204612;6570.244421891496;6574;6574.506911981621;6575.375339342755;6578.3092775258865;5944;6093.756249750005;6155.322914479404;6160.599561028564;6162.322144564095;28393.432131357466;28838.279043023882;28861.278468038257;28863.567046494318;28938.421231575252;2007.3476120260827;2033.7762846086919;2035.216441669953;2040.55107876267;2043.1010355443707;17669.20488578017;18065.187066582035;18333.175007124577;18345.816541834545;18466.63066738671;2410.3853517352964;2449.4084643864458;2458.508298340339;2461.396957745364;2468.2471846086937;116318;124700;140727;149335.99999999892;150239;14347.252483658916;14475.175138682198;14620.383547465715;14804.378562828128;14908.180050097131;22509;22512.437189070406;22547.210847620256;22554.548909021727;22558.210462633728;10207.234457415576;10230.948845255725;10328.845067323997;10347.327423717434;10393.480325983823;9495.477748723886;9533.856992145124;9535.094166054214;9567.282453815991;9716.31985761004;8948.463092214488;9091.27269818413;9107.362484626012;9149.039350868195;9152.81694366109;2671.879765410561;2685.986570067176;2707.5803250496206;2713.4980028694754;2768.9723102768717;968.7626531499827;981.2689546288061;982.5136557403988;989.6387818446216;1005.4470041477158;18464;18761.530961726065;18788.436346909613;18820.623587528175;19052.428427147206;1039.8804137524282;1043.859079024322;1046.947652617366;1047.2355180718118;1053.3837704942541;10223.488825558841;10417.947910260551;10482.318649287772;10620.734481638021;10701.518431670593;502912;509913;511491;517476;518909;112960.43519782512;114651.42674286575;116377;116521;118049;1137.6757624077097;1150.0914277720674;1172.607176595833;1174.5536696055444;1175.0188592525167;16679.916600417404;16727;16793.748093778846;16997.91501042487;17267.568310792332;54682.726586366814;55223;55616.44383556113;56327.71836140793;57439.13841292467;70337.29662703308;70707;70720.58558828897;71122;71210.64394677994;13571.728565428833;13948.16311021342;13969.441222350992;14001;14005.439782408997;21554.461138471663;21590.784092158876;21593.78406215918;21673.783262167806;21740.565188696455;17473.56316092108;17500.649986999935;17583.384581540096;17696.646067078844;17837.286508539513;15540.766888496908;15579.376824926876;15987.360505580113;16368.754468683217;16478.75281870797;16561.83438165603;16861.494155175365;17612.383566575107;17682.646347073245;17901.731474027638;13523.59429217125;13623.86376136226;13654.863451365756;13694.589162325146;13741.106828056145;16828.66342673164;17342.78600497953;17386.913065434594;17551;17558 23:05:05 INFO - PID 31082 | |3;mootools.html;1333.1334632488881;1402.410987385298;1420.8650178233077;1421.8435972043073;1440.913545187289;14662.706745865089;15340.61648458789;15354.692906141898;15367.077975321461;15371.923140384282;15076.547703568884;15137.470188543402;15195.088294702298;15216.847831521682;15217;2676.9063082792104;2701.594760785888;2729.836209827407;2736.4253506763503;2749.42262124954;2663.054615611459;2686.1001564475923;2699.4061306512535;2706.91879243623;2714.8506832124226;2581.1353196679133;2700;2773.292810333362;2782.1931639824425;2782.9721702782917;2683.114572191172;2686.7447592478684;2689.1529168311918;2717.035452414384;2723.8229515081557;2606.7914566834606;2672.2250547341246;2692.932676683079;2711.3357227479396;2718.6465759451344;14890;14923.477678281208;14925.776113358308;14986.550403487912;15078;7904.565248911365;8135.227153420416;8140.226678465537;8142.715004974797;8148.470349427268;5147.588192944556;5236.7119808410525;5346.6524675896335;5360.383555891044;5364.30264065669;1875.259272587334;1901.2490066423686;1924.1052910396593;1975.3580086471811;1979.7525309336334;25969.350766230997;26318;26327.605085923537;26525.73474265252;27579.724202757916;6730.360615741497;6783.287754785676;6948.583085014915;7011.193712723;7059.2234854166;17169;17276.30894764195;17302.480925572254;17313.82686173147;17314.91342543279;7875.015623047119;8037.598120094089;8052.637631306605;8062.314703250172;8063.1130575636635;7231.096112985877;7324.340809327186;7398.297161769623;7404.444666650023;7408.962955185298;5236.769359200584;5392.137258038695;5413.188021796684;5434.2392065110125;5457.154141108134;1549.2253873063469;1549.6048507630483;1552.3247387386523;1572.4889410941262;1584.3583348743778;878.83302172587;913.36064754672;914.1315750037359;922.4096578189964;931.4876817750346;8579.957100214584;8695.739127826175;8731.519766412908;8739.431936924208;8795.648174073094;701.2041333086983;719.3525826755857;741.0625558668289;747.2826086956583;750.7109762741384;4695.694779839299;4869.074875773592;5443.8094666686475;5448.645838020595;5585.832425027174;20754.48113797167;22242.110315587517;22253.22113726012;22450.438739031655;22468;20942.47643808917;21571.137154513643;21771.891140544198;22340.106395743987;22372.664410033864;9965.451900145561;10422.114120299859;10893.83659245112;11189.944050279697;11216.887831121747;7769.805754855947;8953.776155596162;8985.191332780081;9021.864672029793;9026.18764311215;18042.819571804637;18306.26774928988;18686.71969920425;18781.6243675123;19023.71464428007;18666.626667466848;18745.15646795925;18747;18795.718064228775;18952.810471895104;10808.081313088476;10961.342319460859;11040.558377665126;11063;11067.944660276647;13853.445862165401;14017.229052402216;14040.648983775487;14041.648958776112;14052.367643455864;11501;11580;11594.5362185515;11758.58844940423;11806.350650714294;11124.276922000045;11139.275947063416;11216.495257713586;11251.718707032389;11294.378809165575;9474;9637.37357071788;9645.614175432904;9659;9665;7472.439567032603;7577.696892124253;7583.393328533814;7583.696652133853;7606.695732170872;6882.655867206719;7032.613206273704;7085.787426377217;7097.609631470319;7197.532160409557 23:05:05 INFO - PID 31082 | |4;prototype.html;499.0194268262863;503.9949600503994;524.4545672500599;527.6016607461366;529.2378974277041;6222.16891314452;6301.873962520753;6306.369363063692;6360.236771587411;6437.388448097435;6213.378662133784;6244.313125556185;6304.936950630504;6306.7161977711;6329.367063293668;5253.789848406069;5273.76066624343;5277.39039592924;5279.128943724281;5316.12283973144;4947.752612369385;5088.465711100337;5108.182690769478;5192.3249977503065;5219.373675158986;4989.376327959005;5005.799768009275;5008.799648014094;5070.72111033893;5107.974460127694;5034.51481812866;5042.268871013719;5071.999999999982;5082.949170508303;5086.109930762139;4562.885927851797;4568.565986231302;4586.197415452316;4592.7014744041535;4607.401037865089;6166.8766624667705;6295.779647712354;6312.400321969406;6327.810165695037;6338.334474880117;5719.513841323493;5725.799597014126;5727.684977326246;5738.991353026449;5746.080627099685;6665;6676.464413184995;6700.966495167541;6727.327267273283;6732.394084532416;4949.950500494985;4957.132501812204;4968.410108765197;4971.7514124294;4978.327925730016;6922.5154239203275;6961.965190174067;6967.123013890297;6974.709678709404;6975.616341101238;5019.472955339636;5029.698218106925;5049.722265275372;5056.409948936296;5067.454426399983;5128.948710512847;5148.742562871841;5152.330197074431;5152.892128192381;5169.415292353823;5698.6580805151825;5706.457886500776;5743.396943320975;5746.741396637161;5765.1928729977835;6450.838729031811;6568.6058836469965;6616.900746488806;6673.799786006428;6725.226598941184;1682.4111560953813;1748.6677531269017;1759.6128851652873;1774.9290028398977;1783.3401641392768;1198.2930071258;1200.5677955935855;1216.385725208764;1219.7560487902456;1243.8258643789877;5611.839441814931;5737.254156959569;5744.454276843693;5748.770049197985;5824.504917082011;6751.763688270887;6780.898286525706;6804.387605115563;6890.724371025103;6905.861882762317;5726.284214473191;5734.311882574035;5737.913931291034;5809.186713860063;5843.152742852262;3488.284901595167;3550.3076900004253;3594.694450971697;3636.309101270803;3654.506641603403;6400.455961243253;6554.3614096475885;6561.670606934565;6566.212054553389;6607.933920660732;6810.897836532456;6901.378875901193;6956.79129626112;6971.6862741176765;7026.559555291153;6580.473562115019;6604.306547812411;6634.535582509178;6637.601743895381;6645.767398141139;6810.761623343357;6828.7268509259075;6829.965850170717;6875.5874647521305;6891.689873955584;6664.333566643297;6756.594604323756;6792.150981127359;6809.557378770364;6813.2846051163915;6506.739730410731;6590.340965903563;6608.620896477169;6644.235912870082;6697.933020669731;4948.554630083309;5034.647574669884;5034.974825125851;5084.720340381315;5125.231795030709;6585.670716464253;6756.729730810909;6757.493188011017;6778.932210678027;6864.656767161722;6388.840278993062;6587.934120658732;6616.735330586723;6647.169103862017;6679.964605486158;6477.222733272038;6580.21037475506;6583.506237032146;6644;6654.633995130121;6254.653760238432;6442.967785161044;6518.511111666549;6543.901841472477;6551.44312733423;6643.833904152435;6653.600783952978;6654.201495820533;6661.833454163685;6735.158105236846;6396.872062558816;6407.359264073555;6433.654499660244;6444.258910225384;6523.9347606525225 23:05:05 INFO - PID 31082 | |5;yui.html;906.410832958577;920.1028996728189;921.5254144115777;924.9398789078705;934.0612684252326;18809.059547022647;19626.901865490687;19711.408657740292;19773.110210040548;19806.009699515038;17930.820691793077;18105.547361315974;18109.4567162985;18115.18481668325;18116.909415452938;949.852772820214;968.4479846487505;969.6848524229654;970.8495183246608;972.1542258235345;973.2068364283122;974.5517062151418;975.4293738163183;975.6048800235881;975.7219192530131;1010.9443980581065;1027.1269420992135;1031.257494603884;1037.5227395398126;1037.9688609341695;982.3172894838091;1034.3328553083295;1035.7824856780085;1036.4403222260007;1038.4392428088822;746.7535713214626;752.0749478141917;752.1200195770906;752.3755283115001;752.5635131623645;19740.50648733793;20017.899910500353;20027.89986050075;20035.29876454317;20051.699224511645;20756.79243207579;20872.26947056846;20916.058777355054;20981.790182098135;21451.57096858054;16654.75017874733;16741.748873766905;16906.15469226546;16923.576910577212;17122;3256.902292931216;3266.4120458317493;3269.2480729432127;3276.950845737316;3280.2947366316116;105924;144545;146727;147147.264263678;148796;17295.481135565955;17696.380626678005;17917.641647166984;17922.731159032624;17923.28306867711;31199.844000780304;32177.195570110467;32204.355912882078;32225.355492890012;32237.194070148435;8749.56252187388;9003.14470125337;9034.14175653312;9066.54667266634;9071.138241867013;4370.737755734666;4466.731996080181;4467.955320446754;4472.888177795581;4475.619572336323;5649.943500565024;5660.094384898479;5700.771969121189;5748.597598168171;5751.568632352591;1074.5272080284806;1087.1465899269035;1098.8022156011994;1103.475848971732;1104.364990130662;662.8309781005813;673.8820706376365;679.5956405938557;682.4472177536212;684.9280825513349;11475.02462290698;11789.233699809485;12031.977281930958;12677.112602117762;12922.547710830077;684.9726010959506;695.8364784275691;696.1298377028714;703.3072423662688;711.5481669140133;5432.91850622241;5468.234447177399;5499.230107784913;5517.310336207974;5652.293463317085;124193.37903310425;124770.37614811868;127327;128246;129098.35450822685;102859;103170;103955.4802225984;104473.47763261288;105642.47178764056;94850.5257473722;95377.52311238539;96099;96928;99503.50248248712;10282.485875706036;10317.587296508056;10478.895211047791;10508.21188410857;10538.683839484827;44375.778121109186;44727;45199.548004519536;45259.773701131286;45516.54483455256;56959.71520142373;57717;57746.133807992075;58097.12854307274;60001.69999150151;15651.217439128226;15932.442364517186;16062.759058613896;16095.919520402324;16115.113668748332;17844.643107138043;18030.639387212446;18151.90924045371;18197.090145492406;18231.45305640833;15591;15718.13550254747;15743.606409839846;15808.446704365291;15823.841761582236;16121.435749748702;16154.838451615333;16160.595985100466;16193.919030404773;16312;14632.122072675673;14708.632284192552;14758;14828.555143345286;14952.028118172284;10549.472526373496;10922.29005114665;10922.453877305945;10930;11059.50232239535;11817.822732658846;11853.940730296294;11869.643910682693;12098.939505302416;12182 23:05:05 INFO - PID 31082 | __end_tp_report 23:05:05 INFO - PID 31082 | __start_cc_report 23:05:05 INFO - PID 31082 | _x_x_mozilla_cycle_collect,366 23:05:05 INFO - PID 31082 | __end_cc_report 23:05:05 INFO - PID 31082 | __startTimestamp1505369105589__endTimestamp 23:05:05 INFO - PID 31082 | 23:05:05 INFO - PID 31082 | ------- Summary: start ------- 23:05:05 INFO - PID 31082 | Number of tests: 6 23:05:05 INFO - PID 31082 | 23:05:05 INFO - PID 31082 | [#0] dojo.html Cycles:165 Average:6206.16 Median:6559.93 stddev:899.73 (13.7%) stddev-sans-first:869.76 23:05:05 INFO - PID 31082 | Values: 3140.7 3145.2 3152.3 3161.0 3166.6 6177.1 6195.2 6195.7 6262.4 6315.9 6285.3 6302.3 6309.7 6310.8 6324.4 5800.4 5860.3 5871.7 5877.9 5910.1 12.0 5806.6 5901.8 5904.4 5913.8 5427.7 5720.2 5731.9 5829.7 5833.3 5777.2 5788.2 5855.3 5868.3 5892.7 5750.4 5773.2 5840.0 5841.4 5849.2 6190.4 6265.3 6297.5 6382.3 6412.2 6594.7 6750.6 6794.2 6865.4 6899.2 6706.9 6761.6 6780.3 6789.6 6798.6 6212.1 6275.7 6308.7 6333.4 6383.3 6888.4 6981.1 6987.2 6991.2 6993.2 6565.3 6566.3 6635.0 6644.7 6670.3 6624.6 6690.7 6692.9 6709.1 6711.5 6731.5 6758.4 6806.1 6806.6 6830.4 6771.9 6781.7 6842.2 6863.6 6863.6 5251.5 5257.4 5353.4 5422.3 5427.5 4610.9 4635.4 4651.3 4672.0 4765.8 5820.4 5824.1 5882.7 5883.2 5886.6 6739.6 6843.7 6912.4 6912.9 6922.0 5810.0 5812.6 5875.8 5894.3 5906.0 5728.6 5804.4 5822.7 5823.9 5833.6 6513.2 6615.3 6661.0 6678.7 6684.7 6761.9 6852.3 6852.8 6943.9 6955.6 6376.9 6571.4 6573.7 6664.0 6666.9 6660.9 6728.0 6761.2 6801.4 6817.7 6840.0 6845.6 6915.7 6917.9 6919.0 6635.1 6640.7 6717.7 6727.8 6740.4 6493.8 6559.9 6599.0 6611.6 6707.6 6572.9 6604.2 6604.4 6616.4 6622.1 6582.9 6645.5 6716.8 6717.6 6765.7 6229.5 6464.6 6472.8 6543.8 6565.1 23:05:05 INFO - PID 31082 | 23:05:05 INFO - PID 31082 | [#1] ext.html Cycles:180 Average:38213.56 Median:3603.41 stddev:54148.88 (1502.7%) stddev-sans-first:54227.96 23:05:05 INFO - PID 31082 | Values: 811.7 832.2 858.1 860.9 872.5 41782.8 42778.6 42850.6 42862.0 42892.8 39561.4 39837.2 39906.8 43241.1 43987.6 7877.7 7970.9 7972.7 7976.8 7989.5 7813.0 7928.1 7937.8 7941.5 7946.4 7982.1 8000.2 8009.0 8022.2 8023.7 7917.8 7955.2 7971.1 7972.2 7977.7 7775.1 7837.4 7841.3 7843.9 7847.2 38981.4 39062.8 39105.6 39130.4 39248.4 3561.6 3594.7 3596.6 3601.1 3605.7 32118.5 32152.0 32183.2 32285.4 32303.0 5095.1 5251.2 5292.5 5301.6 5332.3 185407.0 189375.0 189772.0 193055.0 193496.0 49817.3 50733.7 50805.5 50807.0 50849.0 52189.2 52391.0 52440.2 52442.0 52485.5 16452.9 16593.9 16618.3 16619.3 16633.0 13578.5 13586.6 13590.3 13599.3 13608.9 13389.1 13420.0 13452.8 13464.6 13611.7 5050.8 5089.9 5130.7 5155.7 5214.5 999.5 1000.4 1011.7 1021.6 1023.7 23063.7 23168.8 23226.3 23256.3 23390.6 1082.8 1109.8 1110.7 1111.3 1120.0 12315.1 12347.9 12384.6 12400.6 12443.7 223150.0 230043.0 238401.0 239581.0 239770.0 53793.0 53853.0 54086.9 54145.7 54229.5 1446.2 1453.0 1462.5 1472.9 1479.9 22447.3 22996.0 23106.9 23144.3 23315.5 38580.2 38614.2 38624.8 38688.8 38744.6 199004.0 199745.0 199960.0 200050.0 200079.0 35078.6 35530.8 36095.3 36145.5 36187.6 44015.1 45224.8 45423.5 45545.3 45726.8 33087.3 33120.7 33124.3 33131.5 33842.5 32569.2 32612.7 32744.3 32980.5 33606.5 35553.8 36784.6 36886.4 36939.0 37129.8 31846.7 32477.4 32698.7 32722.2 33193.3 23563.3 23781.4 23831.0 23942.6 24243.9 23:05:05 INFO - PID 31082 | 23:05:05 INFO - PID 31082 | [#2] jquery.html Cycles:180 Average:34930.18 Median:21904.17 stddev:86024.88 (392.7%) stddev-sans-first:86227.52 23:05:05 INFO - PID 31082 | Values: 572.4 582.2 583.4 589.2 590.6 22067.8 22577.5 22714.1 22736.7 22744.5 23383.2 24265.5 24569.8 24684.3 24776.8 6299.1 6476.0 6480.4 6482.9 6483.1 6339.1 6377.8 6461.9 6464.6 6466.7 6574.0 6590.0 6593.0 6594.4 6594.5 6570.2 6574.0 6574.5 6575.4 6578.3 5944.0 6093.8 6155.3 6160.6 6162.3 28393.4 28838.3 28861.3 28863.6 28938.4 2007.3 2033.8 2035.2 2040.6 2043.1 17669.2 18065.2 18333.2 18345.8 18466.6 2410.4 2449.4 2458.5 2461.4 2468.2 116318.0 124700.0 140727.0 149336.0 150239.0 14347.3 14475.2 14620.4 14804.4 14908.2 22509.0 22512.4 22547.2 22554.5 22558.2 10207.2 10230.9 10328.8 10347.3 10393.5 9495.5 9533.9 9535.1 9567.3 9716.3 8948.5 9091.3 9107.4 9149.0 9152.8 2671.9 2686.0 2707.6 2713.5 2769.0 968.8 981.3 982.5 989.6 1005.4 18464.0 18761.5 18788.4 18820.6 19052.4 1039.9 1043.9 1046.9 1047.2 1053.4 10223.5 10417.9 10482.3 10620.7 10701.5 502912.0 509913.0 511491.0 517476.0 518909.0 112960.4 114651.4 116377.0 116521.0 118049.0 1137.7 1150.1 1172.6 1174.6 1175.0 16679.9 16727.0 16793.7 16997.9 17267.6 54682.7 55223.0 55616.4 56327.7 57439.1 70337.3 70707.0 70720.6 71122.0 71210.6 13571.7 13948.2 13969.4 14001.0 14005.4 21554.5 21590.8 21593.8 21673.8 21740.6 17473.6 17500.6 17583.4 17696.6 17837.3 15540.8 15579.4 15987.4 16368.8 16478.8 16561.8 16861.5 17612.4 17682.6 17901.7 13523.6 13623.9 13654.9 13694.6 13741.1 16828.7 17342.8 17386.9 17551.0 17558.0 23:05:05 INFO - PID 31082 | 23:05:05 INFO - PID 31082 | [#3] mootools.html Cycles:180 Average:9359.66 Median:2687.95 stddev:6689.52 (248.9%) stddev-sans-first:6681.11 23:05:05 INFO - PID 31082 | Values: 1333.1 1402.4 1420.9 1421.8 1440.9 14662.7 15340.6 15354.7 15367.1 15371.9 15076.5 15137.5 15195.1 15216.8 15217.0 2676.9 2701.6 2729.8 2736.4 2749.4 2663.1 2686.1 2699.4 2706.9 2714.9 2581.1 2700.0 2773.3 2782.2 2783.0 2683.1 2686.7 2689.2 2717.0 2723.8 2606.8 2672.2 2692.9 2711.3 2718.6 14890.0 14923.5 14925.8 14986.6 15078.0 7904.6 8135.2 8140.2 8142.7 8148.5 5147.6 5236.7 5346.7 5360.4 5364.3 1875.3 1901.2 1924.1 1975.4 1979.8 25969.4 26318.0 26327.6 26525.7 27579.7 6730.4 6783.3 6948.6 7011.2 7059.2 17169.0 17276.3 17302.5 17313.8 17314.9 7875.0 8037.6 8052.6 8062.3 8063.1 7231.1 7324.3 7398.3 7404.4 7409.0 5236.8 5392.1 5413.2 5434.2 5457.2 1549.2 1549.6 1552.3 1572.5 1584.4 878.8 913.4 914.1 922.4 931.5 8580.0 8695.7 8731.5 8739.4 8795.6 701.2 719.4 741.1 747.3 750.7 4695.7 4869.1 5443.8 5448.6 5585.8 20754.5 22242.1 22253.2 22450.4 22468.0 20942.5 21571.1 21771.9 22340.1 22372.7 9965.5 10422.1 10893.8 11189.9 11216.9 7769.8 8953.8 8985.2 9021.9 9026.2 18042.8 18306.3 18686.7 18781.6 19023.7 18666.6 18745.2 18747.0 18795.7 18952.8 10808.1 10961.3 11040.6 11063.0 11067.9 13853.4 14017.2 14040.6 14041.6 14052.4 11501.0 11580.0 11594.5 11758.6 11806.4 11124.3 11139.3 11216.5 11251.7 11294.4 9474.0 9637.4 9645.6 9659.0 9665.0 7472.4 7577.7 7583.4 7583.7 7606.7 6882.7 7032.6 7085.8 7097.6 7197.5 23:05:05 INFO - PID 31082 | 23:05:05 INFO - PID 31082 | [#4] prototype.html Cycles:180 Average:5586.49 Median:6298.83 stddev:1566.68 (24.9%) stddev-sans-first:1523.83 23:05:05 INFO - PID 31082 | Values: 499.0 504.0 524.5 527.6 529.2 6222.2 6301.9 6306.4 6360.2 6437.4 6213.4 6244.3 6304.9 6306.7 6329.4 5253.8 5273.8 5277.4 5279.1 5316.1 4947.8 5088.5 5108.2 5192.3 5219.4 4989.4 5005.8 5008.8 5070.7 5108.0 5034.5 5042.3 5072.0 5082.9 5086.1 4562.9 4568.6 4586.2 4592.7 4607.4 6166.9 6295.8 6312.4 6327.8 6338.3 5719.5 5725.8 5727.7 5739.0 5746.1 6665.0 6676.5 6701.0 6727.3 6732.4 4950.0 4957.1 4968.4 4971.8 4978.3 6922.5 6962.0 6967.1 6974.7 6975.6 5019.5 5029.7 5049.7 5056.4 5067.5 5128.9 5148.7 5152.3 5152.9 5169.4 5698.7 5706.5 5743.4 5746.7 5765.2 6450.8 6568.6 6616.9 6673.8 6725.2 1682.4 1748.7 1759.6 1774.9 1783.3 1198.3 1200.6 1216.4 1219.8 1243.8 5611.8 5737.3 5744.5 5748.8 5824.5 6751.8 6780.9 6804.4 6890.7 6905.9 5726.3 5734.3 5737.9 5809.2 5843.2 3488.3 3550.3 3594.7 3636.3 3654.5 6400.5 6554.4 6561.7 6566.2 6607.9 6810.9 6901.4 6956.8 6971.7 7026.6 6580.5 6604.3 6634.5 6637.6 6645.8 6810.8 6828.7 6830.0 6875.6 6891.7 6664.3 6756.6 6792.2 6809.6 6813.3 6506.7 6590.3 6608.6 6644.2 6697.9 4948.6 5034.6 5035.0 5084.7 5125.2 6585.7 6756.7 6757.5 6778.9 6864.7 6388.8 6587.9 6616.7 6647.2 6680.0 6477.2 6580.2 6583.5 6644.0 6654.6 6254.7 6443.0 6518.5 6543.9 6551.4 6643.8 6653.6 6654.2 6661.8 6735.2 6396.9 6407.4 6433.7 6444.3 6523.9 23:05:05 INFO - PID 31082 | 23:05:05 INFO - PID 31082 | [#5] yui.html Cycles:180 Average:24348.22 Median:19669.16 stddev:35431.25 (180.1%) stddev-sans-first:35486.92 23:05:05 INFO - PID 31082 | Values: 906.4 920.1 921.5 924.9 934.1 18809.1 19626.9 19711.4 19773.1 19806.0 17930.8 18105.5 18109.5 18115.2 18116.9 949.9 968.4 969.7 970.8 972.2 973.2 974.6 975.4 975.6 975.7 1010.9 1027.1 1031.3 1037.5 1038.0 982.3 1034.3 1035.8 1036.4 1038.4 746.8 752.1 752.1 752.4 752.6 19740.5 20017.9 20027.9 20035.3 20051.7 20756.8 20872.3 20916.1 20981.8 21451.6 16654.8 16741.7 16906.2 16923.6 17122.0 3256.9 3266.4 3269.2 3277.0 3280.3 105924.0 144545.0 146727.0 147147.3 148796.0 17295.5 17696.4 17917.6 17922.7 17923.3 31199.8 32177.2 32204.4 32225.4 32237.2 8749.6 9003.1 9034.1 9066.5 9071.1 4370.7 4466.7 4468.0 4472.9 4475.6 5649.9 5660.1 5700.8 5748.6 5751.6 1074.5 1087.1 1098.8 1103.5 1104.4 662.8 673.9 679.6 682.4 684.9 11475.0 11789.2 12032.0 12677.1 12922.5 685.0 695.8 696.1 703.3 711.5 5432.9 5468.2 5499.2 5517.3 5652.3 124193.4 124770.4 127327.0 128246.0 129098.4 102859.0 103170.0 103955.5 104473.5 105642.5 94850.5 95377.5 96099.0 96928.0 99503.5 10282.5 10317.6 10478.9 10508.2 10538.7 44375.8 44727.0 45199.5 45259.8 45516.5 56959.7 57717.0 57746.1 58097.1 60001.7 15651.2 15932.4 16062.8 16095.9 16115.1 17844.6 18030.6 18151.9 18197.1 18231.5 15591.0 15718.1 15743.6 15808.4 15823.8 16121.4 16154.8 16160.6 16193.9 16312.0 14632.1 14708.6 14758.0 14828.6 14952.0 10549.5 10922.3 10922.5 10930.0 11059.5 11817.8 11853.9 11869.6 12098.9 12182.0 23:05:05 INFO - PID 31082 | -------- Summary: end -------- 23:05:05 INFO - PID 31082 | 23:05:06 INFO - TEST-INFO | 31082: exit 0 23:05:06 INFO - TEST-OK | dromaeo_css | took 1107653ms 23:05:06 INFO - TEST-START | kraken 23:05:06 INFO - Initialising browser for kraken test... 23:05:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60338/getInfo.html -profile /tmp/tmpdVHC9M/profile 23:05:06 INFO - TEST-INFO | started process 31453 (/builds/slave/test/build/application/firefox/firefox http://localhost:60338/getInfo.html) 23:05:11 INFO - TEST-INFO | 31453: exit 0 23:05:11 INFO - Browser initialized. 23:05:11 INFO - Running cycle 1/1 for kraken test... 23:05:11 INFO - Using env: {'DISPLAY': ':0', 23:05:11 INFO - 'HOME': '/home/cltbld', 23:05:11 INFO - 'JSGC_DISABLE_POISONING': '1', 23:05:11 INFO - 'LANG': 'en_US.UTF-8', 23:05:11 INFO - 'LANGUAGE': 'en_US:en', 23:05:11 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 23:05:11 INFO - 'LOGNAME': 'cltbld', 23:05:11 INFO - 'MAIL': '/var/mail/cltbld', 23:05:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:05:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:05:11 INFO - 'MOZ_CRASHREPORTER': '1', 23:05:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:11 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 23:05:11 INFO - 'MOZ_NO_REMOTE': '1', 23:05:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:05:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:11 INFO - 'NO_EM_RESTART': '1', 23:05:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:05:11 INFO - 'PWD': '/builds/slave/test', 23:05:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:05:11 INFO - 'RUST_BACKTRACE': 'full', 23:05:11 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 23:05:11 INFO - 'SHELL': '/bin/bash', 23:05:11 INFO - 'SHLVL': '1', 23:05:11 INFO - 'STYLO_FORCE_DISABLED': '1', 23:05:11 INFO - 'TERM': 'linux', 23:05:11 INFO - 'TMOUT': '86400', 23:05:11 INFO - 'USER': 'cltbld', 23:05:11 INFO - 'XDG_SESSION_COOKIE': 'dac658600622fd96716c9acf000001b3-1505365421.901742-1376979000', 23:05:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:11 INFO - '_': '/tools/buildbot/bin/python'} 23:05:11 INFO - TEST-INFO | started process 31685 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdVHC9M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 23:05:12 INFO - PID 31685 | 23:05:12 INFO - PID 31685 | (/builds/slave/test/build/application/firefox/firefox:31735): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 23:05:12 INFO - PID 31685 | 23:05:22 INFO - PID 31685 | RSS: Main: 173281280 23:05:22 INFO - PID 31685 | 23:05:25 INFO - PID 31685 | Cycle 1(1): loaded http://localhost:60338/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60338/tests/kraken/driver.html?testName=audio-beat-detection) 23:05:26 INFO - PID 31685 | RSS: Main: 179290112 23:05:26 INFO - PID 31685 | 23:05:28 INFO - PID 31685 | Cycle 1(1): loaded http://localhost:60338/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60338/tests/kraken/driver.html?testName=audio-dft) 23:05:29 INFO - PID 31685 | RSS: Main: 179908608 23:05:29 INFO - PID 31685 | 23:05:32 INFO - PID 31685 | Cycle 1(1): loaded http://localhost:60338/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60338/tests/kraken/driver.html?testName=audio-fft) 23:05:33 INFO - PID 31685 | RSS: Main: 174526464 23:05:33 INFO - PID 31685 | 23:05:35 INFO - PID 31685 | Cycle 1(1): loaded http://localhost:60338/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60338/tests/kraken/driver.html?testName=audio-oscillator) 23:05:35 INFO - PID 31685 | RSS: Main: 174776320 23:05:35 INFO - PID 31685 | 23:05:38 INFO - PID 31685 | Cycle 1(1): loaded http://localhost:60338/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60338/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:05:38 INFO - PID 31685 | RSS: Main: 174874624 23:05:38 INFO - PID 31685 | 23:05:41 INFO - PID 31685 | Cycle 1(1): loaded http://localhost:60338/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60338/tests/kraken/driver.html?testName=imaging-darkroom) 23:05:42 INFO - PID 31685 | RSS: Main: 177213440 23:05:42 INFO - PID 31685 | 23:05:46 INFO - PID 31685 | Cycle 1(1): loaded http://localhost:60338/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60338/tests/kraken/driver.html?testName=imaging-desaturate) 23:05:46 INFO - PID 31685 | RSS: Main: 177086464 23:05:46 INFO - PID 31685 | 23:05:49 INFO - PID 31685 | Cycle 1(1): loaded http://localhost:60338/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60338/tests/kraken/driver.html?testName=json-parse-financial) 23:05:50 INFO - PID 31685 | RSS: Main: 177983488 23:05:50 INFO - PID 31685 | 23:05:51 INFO - PID 31685 | Cycle 1(1): loaded http://localhost:60338/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60338/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:05:52 INFO - PID 31685 | RSS: Main: 178663424 23:05:52 INFO - PID 31685 | 23:05:54 INFO - PID 31685 | Cycle 1(1): loaded http://localhost:60338/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60338/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:05:54 INFO - PID 31685 | RSS: Main: 178855936 23:05:54 INFO - PID 31685 | 23:05:56 INFO - PID 31685 | Cycle 1(1): loaded http://localhost:60338/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60338/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:05:57 INFO - PID 31685 | RSS: Main: 175206400 23:05:57 INFO - PID 31685 | 23:06:00 INFO - PID 31685 | Cycle 1(1): loaded http://localhost:60338/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60338/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:06:00 INFO - PID 31685 | RSS: Main: 175276032 23:06:00 INFO - PID 31685 | 23:06:03 INFO - PID 31685 | Cycle 1(1): loaded http://localhost:60338/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60338/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:06:04 INFO - PID 31685 | RSS: Main: 175312896 23:06:04 INFO - PID 31685 | 23:06:06 INFO - PID 31685 | Cycle 1(1): loaded http://localhost:60338/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60338/tests/kraken/driver.html?testName=ai-astar) 23:06:06 INFO - PID 31685 | RSS: Main: 176939008 23:06:06 INFO - PID 31685 | 23:06:06 INFO - PID 31685 | __start_tp_report 23:06:06 INFO - PID 31685 | _x_x_mozilla_page_load 23:06:06 INFO - PID 31685 | _x_x_mozilla_page_load_details 23:06:06 INFO - PID 31685 | |i|pagename|runs| 23:06:06 INFO - PID 31685 | |0;ai-astar;109;106;107;109;110;108;109;110;111;107 23:06:06 INFO - PID 31685 | |1;audio-beat-detection;118;117;118;116;117;116;120;118;118;118 23:06:06 INFO - PID 31685 | |2;audio-dft;164;163;162;163;161;160;163;165;168;164 23:06:06 INFO - PID 31685 | |3;audio-fft;73;75;79;74;78;84;76;76;75;75 23:06:06 INFO - PID 31685 | |4;audio-oscillator;80;79;78;78;78;79;79;79;78;78 23:06:06 INFO - PID 31685 | |5;imaging-gaussian-blur;113;114;111;114;114;114;114;114;112;114 23:06:06 INFO - PID 31685 | |6;imaging-darkroom;146;148;147;147;147;147;157;149;147;149 23:06:06 INFO - PID 31685 | |7;imaging-desaturate;93;94;94;98;99;94;95;94;94;94 23:06:06 INFO - PID 31685 | |8;json-parse-financial;54;52;54;52;55;52;51;55;51;53 23:06:06 INFO - PID 31685 | |9;json-stringify-tinderbox;37;37;37;38;38;39;39;37;38;37 23:06:06 INFO - PID 31685 | |10;stanford-crypto-aes;76;76;75;74;76;74;73;80;78;73 23:06:06 INFO - PID 31685 | |11;stanford-crypto-ccm;112;113;115;111;114;121;111;118;120;115 23:06:06 INFO - PID 31685 | |12;stanford-crypto-pbkdf2;173;173;172;174;170;170;182;168;171;181 23:06:06 INFO - PID 31685 | |13;stanford-crypto-sha256-iterative;66;66;73;64;66;66;66;64;70;66 23:06:06 INFO - PID 31685 | __end_tp_report 23:06:06 INFO - PID 31685 | __start_cc_report 23:06:06 INFO - PID 31685 | _x_x_mozilla_cycle_collect,961 23:06:06 INFO - PID 31685 | __end_cc_report 23:06:06 INFO - PID 31685 | __startTimestamp1505369166451__endTimestamp 23:06:06 INFO - PID 31685 | 23:06:06 INFO - PID 31685 | ------- Summary: start ------- 23:06:06 INFO - PID 31685 | Number of tests: 14 23:06:06 INFO - PID 31685 | 23:06:06 INFO - PID 31685 | [#0] ai-astar Cycles:10 Average:108.60 Median:109.00 stddev:1.58 (1.4%) stddev-sans-first:1.67 23:06:06 INFO - PID 31685 | Values: 109.0 106.0 107.0 109.0 110.0 108.0 109.0 110.0 111.0 107.0 23:06:06 INFO - PID 31685 | 23:06:06 INFO - PID 31685 | [#1] audio-beat-detection Cycles:10 Average:117.60 Median:118.00 stddev:1.17 (1.0%) stddev-sans-first:1.24 23:06:06 INFO - PID 31685 | Values: 118.0 117.0 118.0 116.0 117.0 116.0 120.0 118.0 118.0 118.0 23:06:06 INFO - PID 31685 | 23:06:06 INFO - PID 31685 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.50 stddev:2.21 (1.4%) stddev-sans-first:2.33 23:06:06 INFO - PID 31685 | Values: 164.0 163.0 162.0 163.0 161.0 160.0 163.0 165.0 168.0 164.0 23:06:06 INFO - PID 31685 | 23:06:06 INFO - PID 31685 | [#3] audio-fft Cycles:10 Average:76.50 Median:76.00 stddev:3.17 (4.2%) stddev-sans-first:3.10 23:06:06 INFO - PID 31685 | Values: 73.0 75.0 79.0 74.0 78.0 84.0 76.0 76.0 75.0 75.0 23:06:06 INFO - PID 31685 | 23:06:06 INFO - PID 31685 | [#4] audio-oscillator Cycles:10 Average:78.60 Median:79.00 stddev:0.70 (0.9%) stddev-sans-first:0.53 23:06:06 INFO - PID 31685 | Values: 80.0 79.0 78.0 78.0 78.0 79.0 79.0 79.0 78.0 78.0 23:06:06 INFO - PID 31685 | 23:06:06 INFO - PID 31685 | [#5] imaging-gaussian-blur Cycles:10 Average:113.40 Median:114.00 stddev:1.07 (0.9%) stddev-sans-first:1.13 23:06:06 INFO - PID 31685 | Values: 113.0 114.0 111.0 114.0 114.0 114.0 114.0 114.0 112.0 114.0 23:06:06 INFO - PID 31685 | 23:06:06 INFO - PID 31685 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:147.50 stddev:3.17 (2.1%) stddev-sans-first:3.24 23:06:06 INFO - PID 31685 | Values: 146.0 148.0 147.0 147.0 147.0 147.0 157.0 149.0 147.0 149.0 23:06:06 INFO - PID 31685 | 23:06:06 INFO - PID 31685 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:94.00 stddev:1.97 (2.1%) stddev-sans-first:1.96 23:06:06 INFO - PID 31685 | Values: 93.0 94.0 94.0 98.0 99.0 94.0 95.0 94.0 94.0 94.0 23:06:06 INFO - PID 31685 | 23:06:06 INFO - PID 31685 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.50 stddev:1.52 (2.8%) stddev-sans-first:1.56 23:06:06 INFO - PID 31685 | Values: 54.0 52.0 54.0 52.0 55.0 52.0 51.0 55.0 51.0 53.0 23:06:06 INFO - PID 31685 | 23:06:06 INFO - PID 31685 | [#9] json-stringify-tinderbox Cycles:10 Average:37.70 Median:38.00 stddev:0.82 (2.2%) stddev-sans-first:0.83 23:06:06 INFO - PID 31685 | Values: 37.0 37.0 37.0 38.0 38.0 39.0 39.0 37.0 38.0 37.0 23:06:06 INFO - PID 31685 | 23:06:06 INFO - PID 31685 | [#10] stanford-crypto-aes Cycles:10 Average:75.50 Median:76.00 stddev:2.22 (2.9%) stddev-sans-first:2.35 23:06:06 INFO - PID 31685 | Values: 76.0 76.0 75.0 74.0 76.0 74.0 73.0 80.0 78.0 73.0 23:06:06 INFO - PID 31685 | 23:06:06 INFO - PID 31685 | [#11] stanford-crypto-ccm Cycles:10 Average:115.00 Median:115.00 stddev:3.59 (3.1%) stddev-sans-first:3.64 23:06:06 INFO - PID 31685 | Values: 112.0 113.0 115.0 111.0 114.0 121.0 111.0 118.0 120.0 115.0 23:06:06 INFO - PID 31685 | 23:06:06 INFO - PID 31685 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.40 Median:173.00 stddev:4.62 (2.7%) stddev-sans-first:4.90 23:06:06 INFO - PID 31685 | Values: 173.0 173.0 172.0 174.0 170.0 170.0 182.0 168.0 171.0 181.0 23:06:06 INFO - PID 31685 | 23:06:06 INFO - PID 31685 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:66.00 stddev:2.75 (4.2%) stddev-sans-first:2.91 23:06:06 INFO - PID 31685 | Values: 66.0 66.0 73.0 64.0 66.0 66.0 66.0 64.0 70.0 66.0 23:06:06 INFO - PID 31685 | -------- Summary: end -------- 23:06:06 INFO - PID 31685 | 23:06:06 INFO - PID 31685 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 23:06:07 INFO - TEST-INFO | 31685: exit 0 23:06:07 INFO - TEST-OK | kraken | took 60912ms 23:06:07 INFO - SUITE-END | took 1168s 23:06:07 INFO - Completed test suite (00:19:29) 23:06:07 INFO - javascript benchmark 23:06:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8521.55156939656, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3140.6702296258877, 3145.2451411661204, 3152.306492571635, 3160.9884836852216, 3166.588343515343, 6177.104319873616, 6195.2255968004, 6195.6902154892305, 6262.373762623735, 6315.905261421077, 6285.277193122793, 6302.306746257908, 6309.747610095591, 6310.779122730705, 6324.430801227889, 5800.390958949291, 5860.296764388258, 5871.706414679249, 5877.911831322523, 5910.0543912973935, 12.00867417255348, 5806.59353845231, 5901.822945311626, 5904.3800400957925, 5913.793017244398, 5427.674339539621, 5720.227769251161, 5731.885362292752, 5829.708514574297, 5833.32916714579, 5777.220075289866, 5788.160716696056, 5855.297364316267, 5868.2664666916635, 5892.705364731746, 5750.367459579485, 5773.162891380726, 5840.0, 5841.386654401269, 5849.210356601847, 6190.350013248634, 6265.342139075377, 6297.527685423612, 6382.266039405481, 6412.230532336102, 6594.670266486656, 6750.594964302158, 6794.175007177311, 6865.41643960264, 6899.206591242021, 6706.932930670729, 6761.628110453923, 6780.254172041072, 6789.558678685919, 6798.626075565842, 6212.099245609361, 6275.7489700411925, 6308.716107775161, 6333.398327158959, 6383.265924418705, 6888.380045795902, 6981.0924579804305, 6987.161540615159, 6991.230964593839, 6993.195782484978, 6565.310642382577, 6566.277709451956, 6635.0, 6644.66776661165, 6670.266270710218, 6624.56940298879, 6690.698918548677, 6692.933070669231, 6709.127813384326, 6711.496637752188, 6731.528792984542, 6758.425533829582, 6806.115205023315, 6806.591604503746, 6830.385265326046, 6771.8984215236815, 6781.6609169541325, 6842.213145488333, 6863.622500762506, 6863.622500762506, 5251.501107394792, 5257.395399529103, 5353.38436079848, 5422.267993820784, 5427.45725427462, 4610.907781844411, 4635.397398338195, 4651.325557794101, 4671.976640116778, 4765.761711914391, 5820.447057529528, 5824.068149096124, 5882.676452795052, 5883.235179426732, 5886.58793884424, 6739.59562426256, 6843.692033858489, 6912.377885990184, 6912.930870691329, 6921.965390173118, 5810.041343178413, 5812.564057695605, 5875.794347197828, 5894.263217097863, 5906.0, 5728.598998070179, 5804.390538993345, 5822.679752613647, 5823.854403639858, 5833.620814647034, 6513.218413790375, 6615.305392933769, 6661.0, 6678.666066696743, 6684.699188536528, 6761.8647627047185, 6852.349026842442, 6852.794416167523, 6943.89584156238, 6955.617441040791, 6376.872462550816, 6571.441427478527, 6573.704183311666, 6664.033715111379, 6666.933330666825, 6660.933390666031, 6727.966360168168, 6761.154855643044, 6801.387875091265, 6817.7272909083085, 6840.0, 6845.5550389224545, 6915.688794004182, 6917.9308206917285, 6919.0, 6635.137432133792, 6640.701168447335, 6717.697703603252, 6727.831804204739, 6740.359665831738, 6493.7727179550375, 6559.934400655932, 6599.0, 6611.570247933869, 6707.5975441473665, 6572.934270657232, 6604.240512341143, 6604.438622717123, 6616.4045235929, 6622.139121914313, 6582.868342633216, 6645.534812563074, 6716.764913228014, 6717.630530320879, 6765.661716914233, 6229.5327850410495, 6464.612123272619, 6472.805815825533, 6543.770968016287, 6565.113709649137], "value": 6141.546776828883, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [811.7037281392294, 832.2301870769538, 858.1075681291458, 860.8665656823187, 872.4721543466203, 41782.79108604456, 42778.57221427785, 42850.571494285046, 42862.0, 42892.78553607231, 39561.40657890134, 39837.203255934866, 39906.8004659977, 43241.13517729643, 43987.56012439875, 7877.6848926042885, 7970.920290797105, 7972.720954766584, 7976.800579985489, 7989.520628762264, 7812.960935195316, 7928.088269848955, 7937.841243175133, 7941.483803552751, 7946.404019698517, 7982.082060563022, 8000.159983201767, 8009.0, 8022.237887400687, 8023.67905283788, 7917.802054948615, 7955.204479552028, 7971.123176450586, 7972.24263694951, 7977.680892764282, 7775.105862825791, 7837.412194085409, 7841.333486653642, 7843.921560784376, 7847.215278472164, 38981.415278770844, 39062.80468597667, 39105.60894391077, 39130.413043804365, 39248.41127383091, 3561.6438356164435, 3594.748367614268, 3596.5504311961004, 3601.135727425399, 3605.693516051139, 32118.518222226685, 32152.0, 32183.195420114684, 32285.35429291401, 32303.0, 5095.133827249377, 5251.212318152269, 5292.470752924715, 5301.5758739301145, 5332.280142180794, 185407.0, 189375.0, 189772.0, 193055.0347248269, 193496.0, 49817.25274120891, 50733.74633126885, 50805.491945080816, 50807.0, 50849.0, 52189.21716174261, 52391.0, 52440.21339679908, 52442.0, 52485.47514524882, 16452.917735411247, 16593.91703041477, 16618.25217865199, 16619.335226591043, 16633.0, 13578.456861725617, 13586.592402227949, 13590.25253611041, 13599.320033998261, 13608.93195534016, 13389.129706569041, 13420.0, 13452.798208026887, 13464.596062118153, 13611.727765444833, 5050.823221187241, 5089.872753181126, 5130.666506677054, 5155.690658560498, 5214.45248248936, 999.4802702594756, 1000.3597697473623, 1011.691434112588, 1021.5913634546092, 1023.7184774187158, 23063.654045189334, 23168.768312317, 23226.287903285785, 23256.3023109307, 23390.64914026291, 1082.8484012238293, 1109.8335249712445, 1110.7056629993058, 1111.3332000799455, 1119.9888001120048, 12315.076369272341, 12347.876521234673, 12384.56654017105, 12400.6279811604, 12443.688907777378, 223150.0, 230043.0, 238401.0, 239581.0, 239770.0, 53793.0, 53853.0, 54086.91826163455, 54145.72927135339, 54229.45770542323, 1446.2479510654612, 1452.978205326921, 1462.4881291548086, 1472.9116253024854, 1479.8890083243584, 22447.326580201967, 22996.0, 23106.884465577565, 23144.3056708299, 23315.533689326458, 38580.228395432496, 38614.2277154461, 38624.80687596544, 38688.80655596704, 38744.61255387523, 199004.0, 199745.0, 199960.0, 200050.0, 200079.0, 35078.64921350856, 35530.822345888104, 36095.27809443744, 36145.45781813222, 36187.638123618424, 44015.11969760523, 45224.773876130406, 45423.54576454193, 45545.31682024839, 45726.77136614296, 33087.338253235284, 33120.66879331176, 33124.33751325008, 33131.50302745413, 33842.49236261409, 32569.18577035593, 32612.673873260963, 32744.34511309713, 32980.50529242111, 33606.49590256099, 35553.82223088868, 36784.632153679195, 36886.44670330001, 36939.0, 37129.81435092807, 31846.68153318437, 32477.35045299128, 32698.673013270516, 32722.181945451553, 33193.336133277684, 23563.267117856154, 23781.405464863517, 23831.04675812948, 23942.565780939687, 24243.87878060669], "value": 17412.6967136437, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.436150391864, 582.18203424189, 583.422411812306, 589.2457654202622, 590.630855715178, 22067.779322206774, 22577.54844903101, 22714.091436342547, 22736.65895011572, 22744.54510909781, 23383.181588644402, 24265.51468970624, 24569.75430245697, 24684.259472215817, 24776.75223247767, 6299.149614801989, 6475.996220585816, 6480.351964803505, 6482.902756458657, 6483.059956306332, 6339.080833279172, 6377.808665740035, 6461.8707625847455, 6464.644444555547, 6466.708998095073, 6573.967130164342, 6589.967050164766, 6592.967035164841, 6594.439472644831, 6594.472442204612, 6570.244421891496, 6574.0, 6574.506911981621, 6575.375339342755, 6578.3092775258865, 5944.0, 6093.756249750005, 6155.322914479404, 6160.599561028564, 6162.322144564095, 28393.432131357466, 28838.279043023882, 28861.278468038257, 28863.567046494318, 28938.421231575252, 2007.3476120260827, 2033.7762846086919, 2035.216441669953, 2040.55107876267, 2043.1010355443707, 17669.20488578017, 18065.187066582035, 18333.175007124577, 18345.816541834545, 18466.63066738671, 2410.3853517352964, 2449.4084643864458, 2458.508298340339, 2461.396957745364, 2468.2471846086937, 116318.0, 124700.0, 140727.0, 149335.99999999892, 150239.0, 14347.252483658916, 14475.175138682198, 14620.383547465715, 14804.378562828128, 14908.180050097131, 22509.0, 22512.437189070406, 22547.210847620256, 22554.548909021727, 22558.210462633728, 10207.234457415576, 10230.948845255725, 10328.845067323997, 10347.327423717434, 10393.480325983823, 9495.477748723886, 9533.856992145124, 9535.094166054214, 9567.282453815991, 9716.31985761004, 8948.463092214488, 9091.27269818413, 9107.362484626012, 9149.039350868195, 9152.81694366109, 2671.879765410561, 2685.986570067176, 2707.5803250496206, 2713.4980028694754, 2768.9723102768717, 968.7626531499827, 981.2689546288061, 982.5136557403988, 989.6387818446216, 1005.4470041477158, 18464.0, 18761.530961726065, 18788.436346909613, 18820.623587528175, 19052.428427147206, 1039.8804137524282, 1043.859079024322, 1046.947652617366, 1047.2355180718118, 1053.3837704942541, 10223.488825558841, 10417.947910260551, 10482.318649287772, 10620.734481638021, 10701.518431670593, 502912.0, 509913.0, 511491.0, 517476.0, 518909.0, 112960.43519782512, 114651.42674286575, 116377.0, 116521.0, 118049.0, 1137.6757624077097, 1150.0914277720674, 1172.607176595833, 1174.5536696055444, 1175.0188592525167, 16679.916600417404, 16727.0, 16793.748093778846, 16997.91501042487, 17267.568310792332, 54682.726586366814, 55223.0, 55616.44383556113, 56327.71836140793, 57439.13841292467, 70337.29662703308, 70707.0, 70720.58558828897, 71122.0, 71210.64394677994, 13571.728565428833, 13948.16311021342, 13969.441222350992, 14001.0, 14005.439782408997, 21554.461138471663, 21590.784092158876, 21593.78406215918, 21673.783262167806, 21740.565188696455, 17473.56316092108, 17500.649986999935, 17583.384581540096, 17696.646067078844, 17837.286508539513, 15540.766888496908, 15579.376824926876, 15987.360505580113, 16368.754468683217, 16478.75281870797, 16561.83438165603, 16861.494155175365, 17612.383566575107, 17682.646347073245, 17901.731474027638, 13523.59429217125, 13623.86376136226, 13654.863451365756, 13694.589162325146, 13741.106828056145, 16828.66342673164, 17342.78600497953, 17386.913065434594, 17551.0, 17558.0], "value": 11742.595407110013, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1333.1334632488881, 1402.410987385298, 1420.8650178233077, 1421.8435972043073, 1440.913545187289, 14662.706745865089, 15340.61648458789, 15354.692906141898, 15367.077975321461, 15371.923140384282, 15076.547703568884, 15137.470188543402, 15195.088294702298, 15216.847831521682, 15217.0, 2676.9063082792104, 2701.594760785888, 2729.836209827407, 2736.4253506763503, 2749.42262124954, 2663.054615611459, 2686.1001564475923, 2699.4061306512535, 2706.91879243623, 2714.8506832124226, 2581.1353196679133, 2700.0, 2773.292810333362, 2782.1931639824425, 2782.9721702782917, 2683.114572191172, 2686.7447592478684, 2689.1529168311918, 2717.035452414384, 2723.8229515081557, 2606.7914566834606, 2672.2250547341246, 2692.932676683079, 2711.3357227479396, 2718.6465759451344, 14890.0, 14923.477678281208, 14925.776113358308, 14986.550403487912, 15078.0, 7904.565248911365, 8135.227153420416, 8140.226678465537, 8142.715004974797, 8148.470349427268, 5147.588192944556, 5236.7119808410525, 5346.6524675896335, 5360.383555891044, 5364.30264065669, 1875.259272587334, 1901.2490066423686, 1924.1052910396593, 1975.3580086471811, 1979.7525309336334, 25969.350766230997, 26318.0, 26327.605085923537, 26525.73474265252, 27579.724202757916, 6730.360615741497, 6783.287754785676, 6948.583085014915, 7011.193712723, 7059.2234854166, 17169.0, 17276.30894764195, 17302.480925572254, 17313.82686173147, 17314.91342543279, 7875.015623047119, 8037.598120094089, 8052.637631306605, 8062.314703250172, 8063.1130575636635, 7231.096112985877, 7324.340809327186, 7398.297161769623, 7404.444666650023, 7408.962955185298, 5236.769359200584, 5392.137258038695, 5413.188021796684, 5434.2392065110125, 5457.154141108134, 1549.2253873063469, 1549.6048507630483, 1552.3247387386523, 1572.4889410941262, 1584.3583348743778, 878.83302172587, 913.36064754672, 914.1315750037359, 922.4096578189964, 931.4876817750346, 8579.957100214584, 8695.739127826175, 8731.519766412908, 8739.431936924208, 8795.648174073094, 701.2041333086983, 719.3525826755857, 741.0625558668289, 747.2826086956583, 750.7109762741384, 4695.694779839299, 4869.074875773592, 5443.8094666686475, 5448.645838020595, 5585.832425027174, 20754.48113797167, 22242.110315587517, 22253.22113726012, 22450.438739031655, 22468.0, 20942.47643808917, 21571.137154513643, 21771.891140544198, 22340.106395743987, 22372.664410033864, 9965.451900145561, 10422.114120299859, 10893.83659245112, 11189.944050279697, 11216.887831121747, 7769.805754855947, 8953.776155596162, 8985.191332780081, 9021.864672029793, 9026.18764311215, 18042.819571804637, 18306.26774928988, 18686.71969920425, 18781.6243675123, 19023.71464428007, 18666.626667466848, 18745.15646795925, 18747.0, 18795.718064228775, 18952.810471895104, 10808.081313088476, 10961.342319460859, 11040.558377665126, 11063.0, 11067.944660276647, 13853.445862165401, 14017.229052402216, 14040.648983775487, 14041.648958776112, 14052.367643455864, 11501.0, 11580.0, 11594.5362185515, 11758.58844940423, 11806.350650714294, 11124.276922000045, 11139.275947063416, 11216.495257713586, 11251.718707032389, 11294.378809165575, 9474.0, 9637.37357071788, 9645.614175432904, 9659.0, 9665.0, 7472.439567032603, 7577.696892124253, 7583.393328533814, 7583.696652133853, 7606.695732170872, 6882.655867206719, 7032.613206273704, 7085.787426377217, 7097.609631470319, 7197.532160409557], "value": 6662.852423816041, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.0194268262863, 503.9949600503994, 524.4545672500599, 527.6016607461366, 529.2378974277041, 6222.16891314452, 6301.873962520753, 6306.369363063692, 6360.236771587411, 6437.388448097435, 6213.378662133784, 6244.313125556185, 6304.936950630504, 6306.7161977711, 6329.367063293668, 5253.789848406069, 5273.76066624343, 5277.39039592924, 5279.128943724281, 5316.12283973144, 4947.752612369385, 5088.465711100337, 5108.182690769478, 5192.3249977503065, 5219.373675158986, 4989.376327959005, 5005.799768009275, 5008.799648014094, 5070.72111033893, 5107.974460127694, 5034.51481812866, 5042.268871013719, 5071.999999999982, 5082.949170508303, 5086.109930762139, 4562.885927851797, 4568.565986231302, 4586.197415452316, 4592.7014744041535, 4607.401037865089, 6166.8766624667705, 6295.779647712354, 6312.400321969406, 6327.810165695037, 6338.334474880117, 5719.513841323493, 5725.799597014126, 5727.684977326246, 5738.991353026449, 5746.080627099685, 6665.0, 6676.464413184995, 6700.966495167541, 6727.327267273283, 6732.394084532416, 4949.950500494985, 4957.132501812204, 4968.410108765197, 4971.7514124294, 4978.327925730016, 6922.5154239203275, 6961.965190174067, 6967.123013890297, 6974.709678709404, 6975.616341101238, 5019.472955339636, 5029.698218106925, 5049.722265275372, 5056.409948936296, 5067.454426399983, 5128.948710512847, 5148.742562871841, 5152.330197074431, 5152.892128192381, 5169.415292353823, 5698.6580805151825, 5706.457886500776, 5743.396943320975, 5746.741396637161, 5765.1928729977835, 6450.838729031811, 6568.6058836469965, 6616.900746488806, 6673.799786006428, 6725.226598941184, 1682.4111560953813, 1748.6677531269017, 1759.6128851652873, 1774.9290028398977, 1783.3401641392768, 1198.2930071258, 1200.5677955935855, 1216.385725208764, 1219.7560487902456, 1243.8258643789877, 5611.839441814931, 5737.254156959569, 5744.454276843693, 5748.770049197985, 5824.504917082011, 6751.763688270887, 6780.898286525706, 6804.387605115563, 6890.724371025103, 6905.861882762317, 5726.284214473191, 5734.311882574035, 5737.913931291034, 5809.186713860063, 5843.152742852262, 3488.284901595167, 3550.3076900004253, 3594.694450971697, 3636.309101270803, 3654.506641603403, 6400.455961243253, 6554.3614096475885, 6561.670606934565, 6566.212054553389, 6607.933920660732, 6810.897836532456, 6901.378875901193, 6956.79129626112, 6971.6862741176765, 7026.559555291153, 6580.473562115019, 6604.306547812411, 6634.535582509178, 6637.601743895381, 6645.767398141139, 6810.761623343357, 6828.7268509259075, 6829.965850170717, 6875.5874647521305, 6891.689873955584, 6664.333566643297, 6756.594604323756, 6792.150981127359, 6809.557378770364, 6813.2846051163915, 6506.739730410731, 6590.340965903563, 6608.620896477169, 6644.235912870082, 6697.933020669731, 4948.554630083309, 5034.647574669884, 5034.974825125851, 5084.720340381315, 5125.231795030709, 6585.670716464253, 6756.729730810909, 6757.493188011017, 6778.932210678027, 6864.656767161722, 6388.840278993062, 6587.934120658732, 6616.735330586723, 6647.169103862017, 6679.964605486158, 6477.222733272038, 6580.21037475506, 6583.506237032146, 6644.0, 6654.633995130121, 6254.653760238432, 6442.967785161044, 6518.511111666549, 6543.901841472477, 6551.44312733423, 6643.833904152435, 6653.600783952978, 6654.201495820533, 6661.833454163685, 6735.158105236846, 6396.872062558816, 6407.359264073555, 6433.654499660244, 6444.258910225384, 6523.9347606525225], "value": 5121.740698573833, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [906.410832958577, 920.1028996728189, 921.5254144115777, 924.9398789078705, 934.0612684252326, 18809.059547022647, 19626.901865490687, 19711.408657740292, 19773.110210040548, 19806.009699515038, 17930.820691793077, 18105.547361315974, 18109.4567162985, 18115.18481668325, 18116.909415452938, 949.852772820214, 968.4479846487505, 969.6848524229654, 970.8495183246608, 972.1542258235345, 973.2068364283122, 974.5517062151418, 975.4293738163183, 975.6048800235881, 975.7219192530131, 1010.9443980581065, 1027.1269420992135, 1031.257494603884, 1037.5227395398126, 1037.9688609341695, 982.3172894838091, 1034.3328553083295, 1035.7824856780085, 1036.4403222260007, 1038.4392428088822, 746.7535713214626, 752.0749478141917, 752.1200195770906, 752.3755283115001, 752.5635131623645, 19740.50648733793, 20017.899910500353, 20027.89986050075, 20035.29876454317, 20051.699224511645, 20756.79243207579, 20872.26947056846, 20916.058777355054, 20981.790182098135, 21451.57096858054, 16654.75017874733, 16741.748873766905, 16906.15469226546, 16923.576910577212, 17122.0, 3256.902292931216, 3266.4120458317493, 3269.2480729432127, 3276.950845737316, 3280.2947366316116, 105924.0, 144545.0, 146727.0, 147147.264263678, 148796.0, 17295.481135565955, 17696.380626678005, 17917.641647166984, 17922.731159032624, 17923.28306867711, 31199.844000780304, 32177.195570110467, 32204.355912882078, 32225.355492890012, 32237.194070148435, 8749.56252187388, 9003.14470125337, 9034.14175653312, 9066.54667266634, 9071.138241867013, 4370.737755734666, 4466.731996080181, 4467.955320446754, 4472.888177795581, 4475.619572336323, 5649.943500565024, 5660.094384898479, 5700.771969121189, 5748.597598168171, 5751.568632352591, 1074.5272080284806, 1087.1465899269035, 1098.8022156011994, 1103.475848971732, 1104.364990130662, 662.8309781005813, 673.8820706376365, 679.5956405938557, 682.4472177536212, 684.9280825513349, 11475.02462290698, 11789.233699809485, 12031.977281930958, 12677.112602117762, 12922.547710830077, 684.9726010959506, 695.8364784275691, 696.1298377028714, 703.3072423662688, 711.5481669140133, 5432.91850622241, 5468.234447177399, 5499.230107784913, 5517.310336207974, 5652.293463317085, 124193.37903310425, 124770.37614811868, 127327.0, 128246.0, 129098.35450822685, 102859.0, 103170.0, 103955.4802225984, 104473.47763261288, 105642.47178764056, 94850.5257473722, 95377.52311238539, 96099.0, 96928.0, 99503.50248248712, 10282.485875706036, 10317.587296508056, 10478.895211047791, 10508.21188410857, 10538.683839484827, 44375.778121109186, 44727.0, 45199.548004519536, 45259.773701131286, 45516.54483455256, 56959.71520142373, 57717.0, 57746.133807992075, 58097.12854307274, 60001.69999150151, 15651.217439128226, 15932.442364517186, 16062.759058613896, 16095.919520402324, 16115.113668748332, 17844.643107138043, 18030.639387212446, 18151.90924045371, 18197.090145492406, 18231.45305640833, 15591.0, 15718.13550254747, 15743.606409839846, 15808.446704365291, 15823.841761582236, 16121.435749748702, 16154.838451615333, 16160.595985100466, 16193.919030404773, 16312.0, 14632.122072675673, 14708.632284192552, 14758.0, 14828.555143345286, 14952.028118172284, 10549.472526373496, 10922.29005114665, 10922.453877305945, 10930.0, 11059.50232239535, 11817.822732658846, 11853.940730296294, 11869.643910682693, 12098.939505302416, 12182.0], "value": 8935.131550886048, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1422.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 106.0, 107.0, 109.0, 110.0, 108.0, 109.0, 110.0, 111.0, 107.0], "value": 108.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 116.0, 117.0, 116.0, 120.0, 118.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 162.0, 163.0, 161.0, 160.0, 163.0, 165.0, 168.0, 164.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 79.0, 74.0, 78.0, 84.0, 76.0, 76.0, 75.0, 75.0], "value": 76.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 78.0, 78.0, 78.0, 79.0, 79.0, 79.0, 78.0, 78.0], "value": 78.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 111.0, 114.0, 114.0, 114.0, 114.0, 114.0, 112.0, 114.0], "value": 113.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 147.0, 147.0, 147.0, 147.0, 157.0, 149.0, 147.0, 149.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 98.0, 99.0, 94.0, 95.0, 94.0, 94.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 54.0, 52.0, 55.0, 52.0, 51.0, 55.0, 51.0, 53.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 37.0, 37.0, 38.0, 38.0, 39.0, 39.0, 37.0, 38.0, 37.0], "value": 37.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 74.0, 76.0, 74.0, 73.0, 80.0, 78.0, 73.0], "value": 75.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 115.0, 111.0, 114.0, 121.0, 111.0, 118.0, 120.0, 115.0], "value": 115.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 173.0, 172.0, 174.0, 170.0, 170.0, 182.0, 168.0, 171.0, 181.0], "value": 173.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 73.0, 64.0, 66.0, 66.0, 66.0, 64.0, 70.0, 66.0], "value": 66.7, "unit": "score"}]}]} 23:06:07 INFO - Return code: 0 23:06:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:06:07 INFO - # TBPL SUCCESS # 23:06:07 INFO - Running post-action listener: _package_coverage_data 23:06:07 INFO - Running post-action listener: _resource_record_post_action 23:06:07 INFO - [mozharness: 2017-09-14 06:06:07.713020Z] Finished run-tests step (success) 23:06:07 INFO - Running post-run listener: _resource_record_post_run 23:06:07 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 338931712; Read time: 20; Write time: 217948 23:06:07 INFO - TinderboxPrint: CPU usage
13.1% 23:06:07 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 23:06:07 INFO - TinderboxPrint: I/O write bytes / time
338,931,712 / 217,948 23:06:07 INFO - TinderboxPrint: CPU idle
8,221.0 (86.9%) 23:06:07 INFO - TinderboxPrint: CPU user
1,190.5 (12.6%) 23:06:07 INFO - TinderboxPrint: Swap in / out
0 / 0 23:06:07 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 12787712; Read time: 0; Write time: 1224 23:06:07 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 23:06:07 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 0; Write bytes: 326144000; Read time: 0; Write time: 216724 23:06:08 INFO - Running post-run listener: _upload_blobber_files 23:06:08 INFO - Blob upload gear active. 23:06:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:06:08 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 23:06:08 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'] 23:06:08 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 23:06:08 INFO - (blobuploader) - INFO - Open directory for files ... 23:06:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 23:06:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:06:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:06:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 23:06:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:06:09 INFO - (blobuploader) - INFO - Done attempting. 23:06:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:06:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:06:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:06:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:06:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:06:17 INFO - (blobuploader) - INFO - Done attempting. 23:06:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 23:06:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:06:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:06:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 23:06:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:06:18 INFO - (blobuploader) - INFO - Done attempting. 23:06:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 23:06:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:06:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:06:19 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 23:06:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:06:19 INFO - (blobuploader) - INFO - Done attempting. 23:06:19 INFO - (blobuploader) - INFO - Iteration through files over. 23:06:19 INFO - Return code: 0 23:06:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:06:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:06:19 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/db880e876e04696a7b1df1abf46ce479b30478d4bc35995c80e896805bf58df2809be24bee94bd410d5277989baf4a1803bf7f3756d47c9ddf431932702e4c99", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/75a1b970a31ba3e6725a4c752101d0be3710fcb7bfebbef37160a0565f67465739520705483e6f92efc4c5157c31c2186f4df443eaf55be4c03021d77792ecd7", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b29585fbd199788e7223cbd2e9fd5aab07ad721fa3614515cd0a80774361253bb5536aa6ea9799b369dbde4bd4ba1805ed38087a4900b60eb5e754b73245fc42", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a2576440542f8aa087f09f9f243a3129aa79535c71fbb81124219466cce1e402dd24f743dd6e31dd3ea66b0f09e162e9a876388f37567b7909ea7c275498f90a"} 23:06:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:06:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:06:19 INFO - Contents: 23:06:19 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/db880e876e04696a7b1df1abf46ce479b30478d4bc35995c80e896805bf58df2809be24bee94bd410d5277989baf4a1803bf7f3756d47c9ddf431932702e4c99", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/75a1b970a31ba3e6725a4c752101d0be3710fcb7bfebbef37160a0565f67465739520705483e6f92efc4c5157c31c2186f4df443eaf55be4c03021d77792ecd7", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b29585fbd199788e7223cbd2e9fd5aab07ad721fa3614515cd0a80774361253bb5536aa6ea9799b369dbde4bd4ba1805ed38087a4900b60eb5e754b73245fc42", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a2576440542f8aa087f09f9f243a3129aa79535c71fbb81124219466cce1e402dd24f743dd6e31dd3ea66b0f09e162e9a876388f37567b7909ea7c275498f90a"} 23:06:19 INFO - Running post-run listener: copy_logs_to_upload_dir 23:06:19 INFO - Copying logs to upload dir... 23:06:19 INFO - mkdir: /builds/slave/test/build/upload/logs 23:06:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.716627 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-09-13 23:06:19.921200) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2017-09-13 23:06:19.929181) ========= 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=dac658600622fd96716c9acf000001b3-1505365421.901742-1376979000 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/db880e876e04696a7b1df1abf46ce479b30478d4bc35995c80e896805bf58df2809be24bee94bd410d5277989baf4a1803bf7f3756d47c9ddf431932702e4c99", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/75a1b970a31ba3e6725a4c752101d0be3710fcb7bfebbef37160a0565f67465739520705483e6f92efc4c5157c31c2186f4df443eaf55be4c03021d77792ecd7", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b29585fbd199788e7223cbd2e9fd5aab07ad721fa3614515cd0a80774361253bb5536aa6ea9799b369dbde4bd4ba1805ed38087a4900b60eb5e754b73245fc42", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a2576440542f8aa087f09f9f243a3129aa79535c71fbb81124219466cce1e402dd24f743dd6e31dd3ea66b0f09e162e9a876388f37567b7909ea7c275498f90a"} build_url:https://queue.taskcluster.net/v1/task/XkYgQGM7RR6WsMLSikInwA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011179 build_url: 'https://queue.taskcluster.net/v1/task/XkYgQGM7RR6WsMLSikInwA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/db880e876e04696a7b1df1abf46ce479b30478d4bc35995c80e896805bf58df2809be24bee94bd410d5277989baf4a1803bf7f3756d47c9ddf431932702e4c99", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/75a1b970a31ba3e6725a4c752101d0be3710fcb7bfebbef37160a0565f67465739520705483e6f92efc4c5157c31c2186f4df443eaf55be4c03021d77792ecd7", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b29585fbd199788e7223cbd2e9fd5aab07ad721fa3614515cd0a80774361253bb5536aa6ea9799b369dbde4bd4ba1805ed38087a4900b60eb5e754b73245fc42", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a2576440542f8aa087f09f9f243a3129aa79535c71fbb81124219466cce1e402dd24f743dd6e31dd3ea66b0f09e162e9a876388f37567b7909ea7c275498f90a"}' ========= master_lag: 1.06 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2017-09-13 23:06:20.996046) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 23:06:20.996385) ========= 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=dac658600622fd96716c9acf000001b3-1505365421.901742-1376979000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004296 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 23:06:21.021329) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-13 23:06:21.021647) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-13 23:06:21.021954) ========= ========= Total master_lag: 1.20 =========