builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-084 starttime: 1505153890.58 results: success (0) revision: 02c78441c03d5d004e57596a130856861a30188a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-11 11:18:10.582737) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-11 11:18:10.583210) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-11 11:18:10.583531) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-11 11:18:10.602387) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 11:18:10.602789) ========= 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=ea65d483da93c827905c2090000001f5-1505153888.527711-1463032272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-11 11:18:10-- 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% 109M=0s 2017-09-11 11:18:10 (109 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.170272 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 11:18:10.790229) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 11:18:10.790566) ========= 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=ea65d483da93c827905c2090000001f5-1505153888.527711-1463032272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015923 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 11:18:10.840951) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 27 secs) (at 2017-09-11 11:18:10.841314) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 02c78441c03d5d004e57596a130856861a30188a --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 02c78441c03d5d004e57596a130856861a30188a --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=ea65d483da93c827905c2090000001f5-1505153888.527711-1463032272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-11 11:18:10,924 truncating revision to first 12 chars 2017-09-11 11:18:10,924 Setting DEBUG logging. 2017-09-11 11:18:10,924 attempt 1/10 2017-09-11 11:18:10,924 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/02c78441c03d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-11 11:18:12,412 attempt 1/10 2017-09-11 11:18:12,936 current task status: no status available at this point. state: PENDING 2017-09-11 11:18:12,936 sleeping for 9.00s (attempt 1/10) 2017-09-11 11:18:21,946 attempt 2/10 2017-09-11 11:18:22,480 current task status: no status available at this point. state: PENDING 2017-09-11 11:18:22,480 sleeping for 14.50s (attempt 2/10) 2017-09-11 11:18:36,995 attempt 3/10 2017-09-11 11:18:37,369 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-09-11 11:18:37,561 unpacking tar archive at: mozilla-central-02c78441c03d/testing/mozharness/ program finished with exit code 0 elapsedTime=27.000898 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 27 secs) (at 2017-09-11 11:18:37.858062) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-11 11:18:37.858440) ========= script_repo_revision: 02c78441c03d5d004e57596a130856861a30188a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-11 11:18:37.858903) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-11 11:18:37.859179) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-11 11:18:37.873084) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-11 11:18:37.873584) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ea65d483da93c827905c2090000001f5-1505153888.527711-1463032272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:18:38 INFO - MultiFileLogger online at 20170911 11:18:38 in /builds/slave/test 11:18:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 11:18:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:18:38 INFO - {'append_to_log': False, 11:18:38 INFO - 'base_work_dir': '/builds/slave/test', 11:18:38 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 11:18:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:18:38 INFO - 'branch': 'Firefox-Non-PGO', 11:18:38 INFO - 'buildbot_json_path': 'buildprops.json', 11:18:38 INFO - 'code_coverage': False, 11:18:38 INFO - 'config_files': ('talos/linux_config.py',), 11:18:38 INFO - 'default_actions': ('clobber', 11:18:38 INFO - 'read-buildbot-config', 11:18:38 INFO - 'download-and-extract', 11:18:38 INFO - 'populate-webroot', 11:18:38 INFO - 'create-virtualenv', 11:18:38 INFO - 'install', 11:18:38 INFO - 'setup-mitmproxy', 11:18:38 INFO - 'run-tests'), 11:18:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:18:38 INFO - 'disable_ccov_upload': False, 11:18:38 INFO - 'disable_stylo': False, 11:18:38 INFO - 'download_minidump_stackwalk': True, 11:18:38 INFO - 'download_symbols': 'ondemand', 11:18:38 INFO - 'enable_stylo': False, 11:18:38 INFO - 'enable_webrender': False, 11:18:38 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:18:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:18:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:18:38 INFO - 'gecko_profile': False, 11:18:38 INFO - 'gecko_profile_interval': 0, 11:18:38 INFO - 'installer_path': 'installer.exe', 11:18:38 INFO - 'log_level': 'info', 11:18:38 INFO - 'log_name': 'talos', 11:18:38 INFO - 'log_to_console': True, 11:18:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:18:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:18:38 INFO - 'opt_config_files': (), 11:18:38 INFO - 'pip_index': False, 11:18:38 INFO - 'suite': 'dromaeojs-e10s', 11:18:38 INFO - 'system_bits': '32', 11:18:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:18:38 INFO - 'title': 'talos-linux64-ix-084', 11:18:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:18:38 INFO - 'use_talos_json': True, 11:18:38 INFO - 'verify': 'False', 11:18:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:18:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:18:38 INFO - 'work_dir': 'build'} 11:18:38 INFO - [mozharness: 2017-09-11 18:18:38.099540Z] Running clobber step. 11:18:38 INFO - Running pre-action listener: _resource_record_pre_action 11:18:38 INFO - Running main action method: clobber 11:18:38 INFO - rmtree: /builds/slave/test/build 11:18:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:18:39 INFO - Running post-action listener: _resource_record_post_action 11:18:39 INFO - [mozharness: 2017-09-11 18:18:39.637009Z] Finished clobber step (success) 11:18:39 INFO - [mozharness: 2017-09-11 18:18:39.637105Z] Running read-buildbot-config step. 11:18:39 INFO - Running pre-action listener: _resource_record_pre_action 11:18:39 INFO - Running main action method: read_buildbot_config 11:18:39 INFO - Using buildbot properties: 11:18:39 INFO - { 11:18:39 INFO - "project": "", 11:18:39 INFO - "product": "firefox", 11:18:39 INFO - "who": "ffxbld@noreply.mozilla.org", 11:18:39 INFO - "installer_path": "public/build/target.tar.bz2", 11:18:39 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 11:18:39 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:18:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 11:18:39 INFO - "stage_platform": "linux64", 11:18:39 INFO - "basedir": "/builds/slave/test", 11:18:39 INFO - "buildnumber": 1136, 11:18:39 INFO - "platform": "ubuntu64_hw", 11:18:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:18:39 INFO - "slavebuilddir": "test", 11:18:39 INFO - "taskId": "KzPyu33jTkeO7oBeO-dqfg", 11:18:39 INFO - "branch": "mozilla-central", 11:18:39 INFO - "script_repo_revision": "production", 11:18:39 INFO - "revision": "02c78441c03d5d004e57596a130856861a30188a", 11:18:39 INFO - "slavename": "talos-linux64-ix-084", 11:18:39 INFO - "repo_path": "mozilla-central" 11:18:39 INFO - } 11:18:39 INFO - Finding installer, test and symbols from parent task. 11:18:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KzPyu33jTkeO7oBeO-dqfg'}, attempt #1 11:18:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KzPyu33jTkeO7oBeO-dqfg'}, attempt #1 11:18:40 INFO - Task dependencies: C8epV1-GTcmlPzW_iPUoRQ 11:18:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C8epV1-GTcmlPzW_iPUoRQ'}, attempt #1 11:18:40 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/C8epV1-GTcmlPzW_iPUoRQ/artifacts/public/build/target.tar.bz2 11:18:40 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/C8epV1-GTcmlPzW_iPUoRQ/artifacts/public/build/target.test_packages.json 11:18:40 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/C8epV1-GTcmlPzW_iPUoRQ/artifacts/public/build/target.crashreporter-symbols.zip 11:18:40 INFO - Running post-action listener: _resource_record_post_action 11:18:40 INFO - [mozharness: 2017-09-11 18:18:40.986825Z] Finished read-buildbot-config step (success) 11:18:40 INFO - [mozharness: 2017-09-11 18:18:40.987043Z] Running download-and-extract step. 11:18:40 INFO - Running pre-action listener: _resource_record_pre_action 11:18:40 INFO - Running main action method: download_and_extract 11:18:40 INFO - mkdir: /builds/slave/test/build/tests 11:18:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:40 INFO - trying https://queue.taskcluster.net/v1/task/C8epV1-GTcmlPzW_iPUoRQ/artifacts/public/build/target.test_packages.json 11:18:40 INFO - Downloading https://queue.taskcluster.net/v1/task/C8epV1-GTcmlPzW_iPUoRQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:18:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C8epV1-GTcmlPzW_iPUoRQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:18:41 INFO - Downloaded 989 bytes. 11:18:41 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:18:41 INFO - Using the following test package requirements: 11:18:41 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:18:41 INFO - u'common': [u'target.common.tests.zip'], 11:18:41 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:18:41 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:18:41 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:18:41 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:18:41 INFO - u'mozbase': [u'target.common.tests.zip'], 11:18:41 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:18:41 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:18:41 INFO - u'web-platform': [u'target.common.tests.zip', 11:18:41 INFO - u'target.web-platform.tests.tar.gz'], 11:18:41 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:18:41 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:18:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C8epV1-GTcmlPzW_iPUoRQ/artifacts/public/build/target.common.tests.zip 11:18:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C8epV1-GTcmlPzW_iPUoRQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:18:41 INFO - Fetch https://queue.taskcluster.net/v1/task/C8epV1-GTcmlPzW_iPUoRQ/artifacts/public/build/target.common.tests.zip into memory 11:18:42 INFO - Content-Length response header: 55028420 11:18:42 INFO - Bytes received: 55028420 11:18:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C8epV1-GTcmlPzW_iPUoRQ/artifacts/public/build/target.talos.tests.zip 11:18:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C8epV1-GTcmlPzW_iPUoRQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:18:53 INFO - Fetch https://queue.taskcluster.net/v1/task/C8epV1-GTcmlPzW_iPUoRQ/artifacts/public/build/target.talos.tests.zip into memory 11:18:54 INFO - Content-Length response header: 14497963 11:18:54 INFO - Bytes received: 14497963 11:18: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')]} 11:18:54 INFO - trying https://queue.taskcluster.net/v1/task/C8epV1-GTcmlPzW_iPUoRQ/artifacts/public/build/target.tar.bz2 11:18:54 INFO - Downloading https://queue.taskcluster.net/v1/task/C8epV1-GTcmlPzW_iPUoRQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:18:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C8epV1-GTcmlPzW_iPUoRQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:18:55 INFO - Downloaded 62942570 bytes. 11:18:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C8epV1-GTcmlPzW_iPUoRQ/artifacts/public/build/target.tar.bz2 11:18:55 INFO - mkdir: /builds/slave/test/properties 11:18:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:18:55 INFO - Writing to file /builds/slave/test/properties/build_url 11:18:55 INFO - Contents: 11:18:55 INFO - build_url:https://queue.taskcluster.net/v1/task/C8epV1-GTcmlPzW_iPUoRQ/artifacts/public/build/target.tar.bz2 11:18:55 INFO - Running post-action listener: _resource_record_post_action 11:18:55 INFO - Running post-action listener: find_tests_for_verification 11:18:55 INFO - Running post-action listener: set_extra_try_arguments 11:18:55 INFO - [mozharness: 2017-09-11 18:18:55.571187Z] Finished download-and-extract step (success) 11:18:55 INFO - [mozharness: 2017-09-11 18:18:55.571284Z] Running populate-webroot step. 11:18:55 INFO - Running pre-action listener: _resource_record_pre_action 11:18:55 INFO - Running main action method: populate_webroot 11:18:55 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:18:55 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:18:55 INFO - 'tests': ['tresize', 11:18:55 INFO - 'tcanvasmark']}, 11:18:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:18:55 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:18:55 INFO - 'tests': ['dromaeo_css', 11:18:55 INFO - 'kraken']}, 11:18:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:18:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:18:55 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:18:55 INFO - 'talos_options': ['--disable-stylo'], 11:18:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:18:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:18:55 INFO - 'tests': ['damp', 'tps']}, 11:18:55 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:18:55 INFO - 'talos_options': ['--disable-stylo'], 11:18:55 INFO - 'tests': ['damp', 'tps']}, 11:18:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:18:55 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:18:55 INFO - 'tests': ['dromaeo_dom']}, 11:18:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:18:55 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:18:55 INFO - 'tests': ['basic_compositor_video', 11:18:55 INFO - 'glvideo']}, 11:18:55 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:18:55 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:18:55 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:18:55 INFO - 'talos_options': ['--disable-stylo'], 11:18:55 INFO - 'tests': ['ts_paint_webext', 11:18:55 INFO - 'tp5o_webext']}, 11:18:55 INFO - 'other-e10s': {'tests': ['a11yr', 11:18:55 INFO - 'ts_paint', 11:18:55 INFO - 'tpaint', 11:18:55 INFO - 'sessionrestore', 11:18:55 INFO - 'sessionrestore_many_windows', 11:18:55 INFO - 'sessionrestore_no_auto_restore', 11:18:55 INFO - 'tabpaint']}, 11:18:55 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:18:55 INFO - 'tests': ['a11yr', 11:18:55 INFO - 'ts_paint', 11:18:55 INFO - 'tpaint', 11:18:55 INFO - 'sessionrestore', 11:18:55 INFO - 'sessionrestore_many_windows', 11:18:55 INFO - 'sessionrestore_no_auto_restore', 11:18:55 INFO - 'tabpaint']}, 11:18:55 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:18:55 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:18:55 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:18:55 INFO - 'tests': ['bloom_basic_singleton']}, 11:18:55 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:18:55 INFO - 'tests': ['bloom_basic']}, 11:18:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:18:55 INFO - 'tsvgr_opacity', 11:18:55 INFO - 'tart', 11:18:55 INFO - 'tscrollx', 11:18:55 INFO - 'tsvg_static']}, 11:18:55 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:18:55 INFO - 'tests': ['tsvgx', 11:18:55 INFO - 'tsvgr_opacity', 11:18:55 INFO - 'tart', 11:18:55 INFO - 'tscrollx', 11:18:55 INFO - 'tsvg_static']}, 11:18:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:18:55 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:18:55 INFO - 'talos_options': ['--disable-stylo'], 11:18:55 INFO - 'tests': ['tp5o']}, 11:18:55 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:18:55 INFO - 'talos_options': ['--mitmproxy', 11:18:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:18:55 INFO - '--firstNonBlankPaint'], 11:18:55 INFO - 'tests': ['tp6_google', 11:18:55 INFO - 'tp6_youtube', 11:18:55 INFO - 'tp6_amazon', 11:18:55 INFO - 'tp6_facebook']}, 11:18:55 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:18:55 INFO - 'talos_options': ['--disable-stylo', 11:18:55 INFO - '--mitmproxy', 11:18:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:18:55 INFO - '--firstNonBlankPaint'], 11:18:55 INFO - 'tests': ['tp6_google', 11:18:55 INFO - 'tp6_youtube', 11:18:55 INFO - 'tp6_amazon', 11:18:55 INFO - 'tp6_facebook']}, 11:18:55 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:18:55 INFO - 'talos_options': ['--stylo-threads=1', 11:18:55 INFO - '--mitmproxy', 11:18:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:18:55 INFO - '--firstNonBlankPaint'], 11:18:55 INFO - 'tests': ['tp6_google', 11:18:55 INFO - 'tp6_youtube', 11:18:55 INFO - 'tp6_amazon', 11:18:55 INFO - 'tp6_facebook']}, 11:18:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:18:55 INFO - 'talos_options': ['--xperf_path', 11:18:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:18:55 INFO - 'tests': ['tp5n']}, 11:18:55 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:18:55 INFO - 'talos_options': ['--disable-stylo', 11:18:55 INFO - '--xperf_path', 11:18:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:18:55 INFO - 'tests': ['tp5n']}}} 11:18:55 INFO - Running post-action listener: _resource_record_post_action 11:18:55 INFO - [mozharness: 2017-09-11 18:18:55.586117Z] Finished populate-webroot step (success) 11:18:55 INFO - [mozharness: 2017-09-11 18:18:55.586205Z] Running create-virtualenv step. 11:18:55 INFO - Running pre-action listener: _resource_record_pre_action 11:18:55 INFO - Running main action method: create_virtualenv 11:18:55 INFO - Creating virtualenv /builds/slave/test/build/venv 11:18:55 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:18:55 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:18:55 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:18:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:18:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:18:56 INFO - Installing distribute.............................................................................................................................................................................................done. 11:18:56 INFO - Installing pip...............done. 11:18:56 INFO - Return code: 0 11:18:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:18:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:18:56 INFO - Reading from file tmpfile_stdout 11:18:56 INFO - Output received: 11:18: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) 11:18:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18: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 0x21041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2470a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2474090>, '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 0x2474d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246ef90>, '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': 'ea65d483da93c827905c2090000001f5-1505153888.527711-1463032272', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:18: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 11:18: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 11:18:56 INFO - Using env: {'DISPLAY': ':0', 11:18:56 INFO - 'HOME': '/home/cltbld', 11:18:56 INFO - 'LANG': 'en_US.UTF-8', 11:18:56 INFO - 'LANGUAGE': 'en_US:en', 11:18:56 INFO - 'LOGNAME': 'cltbld', 11:18:56 INFO - 'MAIL': '/var/mail/cltbld', 11:18:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:56 INFO - 'MOZ_NO_REMOTE': '1', 11:18:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:56 INFO - 'NO_EM_RESTART': '1', 11:18:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:56 INFO - 'PWD': '/builds/slave/test', 11:18:56 INFO - 'SHELL': '/bin/bash', 11:18:56 INFO - 'SHLVL': '1', 11:18:56 INFO - 'TERM': 'linux', 11:18:56 INFO - 'TMOUT': '86400', 11:18:56 INFO - 'USER': 'cltbld', 11:18:56 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1505153888.527711-1463032272', 11:18:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:56 INFO - '_': '/tools/buildbot/bin/python'} 11:18:58 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:18:58 INFO - Downloading/unpacking pip>=1.5 11:18:58 INFO - Running setup.py egg_info for package pip 11:18:58 INFO - warning: no files found matching 'pip/cacert.pem' 11:18:58 INFO - warning: no files found matching '*.html' under directory 'docs' 11:18:58 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:18:58 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:18:58 INFO - Installing collected packages: pip 11:18:58 INFO - Found existing installation: pip 1.1 11:18:58 INFO - Uninstalling pip: 11:18:58 INFO - Successfully uninstalled pip 11:18:58 INFO - Running setup.py install for pip 11:18:58 INFO - warning: no files found matching 'pip/cacert.pem' 11:18:58 INFO - warning: no files found matching '*.html' under directory 'docs' 11:18:58 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:18:58 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:18:58 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:18:58 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:18:58 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:18:58 INFO - Successfully installed pip 11:18:58 INFO - Cleaning up... 11:18:58 INFO - Return code: 0 11:18:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:18:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2470a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2474090>, '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 0x2474d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246ef90>, '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': 'ea65d483da93c827905c2090000001f5-1505153888.527711-1463032272', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:18:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:18:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:18:58 INFO - Using env: {'DISPLAY': ':0', 11:18:58 INFO - 'HOME': '/home/cltbld', 11:18:58 INFO - 'LANG': 'en_US.UTF-8', 11:18:58 INFO - 'LANGUAGE': 'en_US:en', 11:18:58 INFO - 'LOGNAME': 'cltbld', 11:18:58 INFO - 'MAIL': '/var/mail/cltbld', 11:18:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:58 INFO - 'MOZ_NO_REMOTE': '1', 11:18:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:58 INFO - 'NO_EM_RESTART': '1', 11:18:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:58 INFO - 'PWD': '/builds/slave/test', 11:18:58 INFO - 'SHELL': '/bin/bash', 11:18:58 INFO - 'SHLVL': '1', 11:18:58 INFO - 'TERM': 'linux', 11:18:58 INFO - 'TMOUT': '86400', 11:18:58 INFO - 'USER': 'cltbld', 11:18:58 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1505153888.527711-1463032272', 11:18:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:58 INFO - '_': '/tools/buildbot/bin/python'} 11:18:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:58 INFO - Downloading/unpacking psutil>=3.1.1 11:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:19:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:19:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:19:00 INFO - Installing collected packages: psutil 11:19:00 INFO - Running setup.py install for psutil 11:19:00 INFO - building 'psutil._psutil_linux' extension 11:19:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:19:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:19:00 INFO - building 'psutil._psutil_posix' extension 11:19:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:19:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:19:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:19:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:19:00 INFO - Successfully installed psutil 11:19:00 INFO - Cleaning up... 11:19:00 INFO - Return code: 0 11:19:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2470a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2474090>, '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 0x2474d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246ef90>, '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': 'ea65d483da93c827905c2090000001f5-1505153888.527711-1463032272', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:19:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:19:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:19:00 INFO - Using env: {'DISPLAY': ':0', 11:19:00 INFO - 'HOME': '/home/cltbld', 11:19:00 INFO - 'LANG': 'en_US.UTF-8', 11:19:00 INFO - 'LANGUAGE': 'en_US:en', 11:19:00 INFO - 'LOGNAME': 'cltbld', 11:19:00 INFO - 'MAIL': '/var/mail/cltbld', 11:19:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:00 INFO - 'MOZ_NO_REMOTE': '1', 11:19:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:00 INFO - 'NO_EM_RESTART': '1', 11:19:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:00 INFO - 'PWD': '/builds/slave/test', 11:19:00 INFO - 'SHELL': '/bin/bash', 11:19:00 INFO - 'SHLVL': '1', 11:19:00 INFO - 'TERM': 'linux', 11:19:00 INFO - 'TMOUT': '86400', 11:19:00 INFO - 'USER': 'cltbld', 11:19:00 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1505153888.527711-1463032272', 11:19:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:00 INFO - '_': '/tools/buildbot/bin/python'} 11:19:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:19:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:19:02 INFO - Installing collected packages: mozsystemmonitor 11:19:02 INFO - Running setup.py install for mozsystemmonitor 11:19:02 INFO - Successfully installed mozsystemmonitor 11:19:02 INFO - Cleaning up... 11:19:02 INFO - Return code: 0 11:19:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19: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', '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 0x21041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2470a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2474090>, '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 0x2474d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246ef90>, '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': 'ea65d483da93c827905c2090000001f5-1505153888.527711-1463032272', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:19: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:19: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 jsonschema==2.5.1 11:19:02 INFO - Using env: {'DISPLAY': ':0', 11:19:02 INFO - 'HOME': '/home/cltbld', 11:19:02 INFO - 'LANG': 'en_US.UTF-8', 11:19:02 INFO - 'LANGUAGE': 'en_US:en', 11:19:02 INFO - 'LOGNAME': 'cltbld', 11:19:02 INFO - 'MAIL': '/var/mail/cltbld', 11:19:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:02 INFO - 'MOZ_NO_REMOTE': '1', 11:19:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:02 INFO - 'NO_EM_RESTART': '1', 11:19:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:02 INFO - 'PWD': '/builds/slave/test', 11:19:02 INFO - 'SHELL': '/bin/bash', 11:19:02 INFO - 'SHLVL': '1', 11:19:02 INFO - 'TERM': 'linux', 11:19:02 INFO - 'TMOUT': '86400', 11:19:02 INFO - 'USER': 'cltbld', 11:19:02 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1505153888.527711-1463032272', 11:19:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:02 INFO - '_': '/tools/buildbot/bin/python'} 11:19:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:02 INFO - Downloading/unpacking jsonschema==2.5.1 11:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:19:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:03 INFO - Downloading functools32-3.2.3-2.tar.gz 11:19:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:19:03 INFO - warning: no files found matching '*.txt' 11:19:03 INFO - no previously-included directories found matching 'build' 11:19:03 INFO - no previously-included directories found matching 'dist' 11:19:03 INFO - no previously-included directories found matching '.git*' 11:19:03 INFO - Installing collected packages: jsonschema, functools32 11:19:03 INFO - Running setup.py install for functools32 11:19:03 INFO - warning: no files found matching '*.txt' 11:19:03 INFO - no previously-included directories found matching 'build' 11:19:03 INFO - no previously-included directories found matching 'dist' 11:19:03 INFO - no previously-included directories found matching '.git*' 11:19:03 INFO - Successfully installed jsonschema functools32 11:19:03 INFO - Cleaning up... 11:19:03 INFO - Return code: 0 11:19:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2470a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2474090>, '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 0x2474d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246ef90>, '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': 'ea65d483da93c827905c2090000001f5-1505153888.527711-1463032272', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:19:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:19:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:19:03 INFO - Using env: {'DISPLAY': ':0', 11:19:03 INFO - 'HOME': '/home/cltbld', 11:19:03 INFO - 'LANG': 'en_US.UTF-8', 11:19:03 INFO - 'LANGUAGE': 'en_US:en', 11:19:03 INFO - 'LOGNAME': 'cltbld', 11:19:03 INFO - 'MAIL': '/var/mail/cltbld', 11:19:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:03 INFO - 'MOZ_NO_REMOTE': '1', 11:19:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:03 INFO - 'NO_EM_RESTART': '1', 11:19:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:03 INFO - 'PWD': '/builds/slave/test', 11:19:03 INFO - 'SHELL': '/bin/bash', 11:19:03 INFO - 'SHLVL': '1', 11:19:03 INFO - 'TERM': 'linux', 11:19:03 INFO - 'TMOUT': '86400', 11:19:03 INFO - 'USER': 'cltbld', 11:19:03 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1505153888.527711-1463032272', 11:19:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:03 INFO - '_': '/tools/buildbot/bin/python'} 11:19:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:19:04 INFO - Cleaning up... 11:19:04 INFO - Return code: 0 11:19:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:04 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 0x21041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2470a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2474090>, '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 0x2474d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246ef90>, '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': 'ea65d483da93c827905c2090000001f5-1505153888.527711-1463032272', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:19:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:19:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:19:04 INFO - Using env: {'DISPLAY': ':0', 11:19:04 INFO - 'HOME': '/home/cltbld', 11:19:04 INFO - 'LANG': 'en_US.UTF-8', 11:19:04 INFO - 'LANGUAGE': 'en_US:en', 11:19:04 INFO - 'LOGNAME': 'cltbld', 11:19:04 INFO - 'MAIL': '/var/mail/cltbld', 11:19:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:04 INFO - 'MOZ_NO_REMOTE': '1', 11:19:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:04 INFO - 'NO_EM_RESTART': '1', 11:19:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:04 INFO - 'PWD': '/builds/slave/test', 11:19:04 INFO - 'SHELL': '/bin/bash', 11:19:04 INFO - 'SHLVL': '1', 11:19:04 INFO - 'TERM': 'linux', 11:19:04 INFO - 'TMOUT': '86400', 11:19:04 INFO - 'USER': 'cltbld', 11:19:04 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1505153888.527711-1463032272', 11:19:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:04 INFO - '_': '/tools/buildbot/bin/python'} 11:19:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:04 INFO - Downloading/unpacking blobuploader==1.2.4 11:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:05 INFO - Downloading blobuploader-1.2.4.tar.gz 11:19:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:19:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:19: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 11:19: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 11:19: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 11:19: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 11:19:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:19:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:19: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 11:19: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 11:19: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 11:19: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 11:19:05 INFO - Downloading docopt-0.6.1.tar.gz 11:19:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:19:05 INFO - Installing collected packages: blobuploader, requests, docopt 11:19:05 INFO - Running setup.py install for blobuploader 11:19:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:19:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:19:06 INFO - Running setup.py install for requests 11:19:06 INFO - Running setup.py install for docopt 11:19:06 INFO - Successfully installed blobuploader requests docopt 11:19:06 INFO - Cleaning up... 11:19:06 INFO - Return code: 0 11:19:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:19: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')]} 11:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19: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')]} 11:19:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:06 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 0x21041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2470a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2474090>, '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 0x2474d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246ef90>, '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': 'ea65d483da93c827905c2090000001f5-1505153888.527711-1463032272', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:19:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:19:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:19:06 INFO - Using env: {'DISPLAY': ':0', 11:19:06 INFO - 'HOME': '/home/cltbld', 11:19:06 INFO - 'LANG': 'en_US.UTF-8', 11:19:06 INFO - 'LANGUAGE': 'en_US:en', 11:19:06 INFO - 'LOGNAME': 'cltbld', 11:19:06 INFO - 'MAIL': '/var/mail/cltbld', 11:19:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:06 INFO - 'MOZ_NO_REMOTE': '1', 11:19:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:06 INFO - 'NO_EM_RESTART': '1', 11:19:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:06 INFO - 'PWD': '/builds/slave/test', 11:19:06 INFO - 'SHELL': '/bin/bash', 11:19:06 INFO - 'SHLVL': '1', 11:19:06 INFO - 'TERM': 'linux', 11:19:06 INFO - 'TMOUT': '86400', 11:19:06 INFO - 'USER': 'cltbld', 11:19:06 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1505153888.527711-1463032272', 11:19:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:06 INFO - '_': '/tools/buildbot/bin/python'} 11:19:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:19:07 INFO - Running setup.py (path:/tmp/pip-NmRJfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:19:07 INFO - Running setup.py (path:/tmp/pip-7Ox5F5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:19:07 INFO - Running setup.py (path:/tmp/pip-SEXFPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:19:07 INFO - Running setup.py (path:/tmp/pip-TFhwr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:19:07 INFO - Running setup.py (path:/tmp/pip-H8Er2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:19:07 INFO - Running setup.py (path:/tmp/pip-0Jd55d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:19:07 INFO - Running setup.py (path:/tmp/pip-G0imil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:19:07 INFO - Running setup.py (path:/tmp/pip-jvFJce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:19:07 INFO - Running setup.py (path:/tmp/pip-dffwKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:19:07 INFO - Running setup.py (path:/tmp/pip-gqW_MS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:19:07 INFO - Running setup.py (path:/tmp/pip-6MSd9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:19:07 INFO - Running setup.py (path:/tmp/pip-GsKL71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:19:07 INFO - Running setup.py (path:/tmp/pip-q50CuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:19:08 INFO - Running setup.py (path:/tmp/pip-9zLMms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:19:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:19:08 INFO - Running setup.py (path:/tmp/pip-GZBCBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:19:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:19:08 INFO - Running setup.py (path:/tmp/pip-nbuwzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:19:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:19:08 INFO - Running setup.py (path:/tmp/pip-7Mg7u7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:19:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:19:08 INFO - Running setup.py install for manifestparser 11:19:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:19:08 INFO - Running setup.py install for mozcrash 11:19:08 INFO - Running setup.py install for mozdebug 11:19:08 INFO - Running setup.py install for mozdevice 11:19:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:19:08 INFO - Running setup.py install for mozfile 11:19:08 INFO - Running setup.py install for mozhttpd 11:19:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:19:08 INFO - Running setup.py install for mozinfo 11:19:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:19:08 INFO - Running setup.py install for mozInstall 11:19:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:19:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:19:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:19:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:19:09 INFO - Running setup.py install for mozleak 11:19:09 INFO - Running setup.py install for mozlog 11:19:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:19:09 INFO - Running setup.py install for moznetwork 11:19:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:19:09 INFO - Running setup.py install for mozprocess 11:19:09 INFO - Running setup.py install for mozprofile 11:19:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:19:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:19:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:19:09 INFO - Running setup.py install for mozrunner 11:19:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:19:09 INFO - Running setup.py install for mozscreenshot 11:19:09 INFO - Running setup.py install for moztest 11:19:09 INFO - Running setup.py install for mozversion 11:19:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:19:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:19:10 INFO - Cleaning up... 11:19:10 INFO - Return code: 0 11:19:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:19:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:10 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 0x21041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2470a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2474090>, '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 0x2474d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246ef90>, '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': 'ea65d483da93c827905c2090000001f5-1505153888.527711-1463032272', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:19:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:19:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:19:10 INFO - Using env: {'DISPLAY': ':0', 11:19:10 INFO - 'HOME': '/home/cltbld', 11:19:10 INFO - 'LANG': 'en_US.UTF-8', 11:19:10 INFO - 'LANGUAGE': 'en_US:en', 11:19:10 INFO - 'LOGNAME': 'cltbld', 11:19:10 INFO - 'MAIL': '/var/mail/cltbld', 11:19:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:10 INFO - 'MOZ_NO_REMOTE': '1', 11:19:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:10 INFO - 'NO_EM_RESTART': '1', 11:19:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:10 INFO - 'PWD': '/builds/slave/test', 11:19:10 INFO - 'SHELL': '/bin/bash', 11:19:10 INFO - 'SHLVL': '1', 11:19:10 INFO - 'TERM': 'linux', 11:19:10 INFO - 'TMOUT': '86400', 11:19:10 INFO - 'USER': 'cltbld', 11:19:10 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1505153888.527711-1463032272', 11:19:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:10 INFO - '_': '/tools/buildbot/bin/python'} 11:19:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:19:10 INFO - Running setup.py (path:/tmp/pip-pnFuTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:19:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:19:10 INFO - Running setup.py (path:/tmp/pip-uwMA0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:19:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:19:10 INFO - Running setup.py (path:/tmp/pip-93luEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:19:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:19:10 INFO - Running setup.py (path:/tmp/pip-Fc8WlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:19:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:19:10 INFO - Running setup.py (path:/tmp/pip-lstwxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:19:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:19:10 INFO - Running setup.py (path:/tmp/pip-E5REU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:19:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:19:10 INFO - Running setup.py (path:/tmp/pip-f92eXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:19:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:19:10 INFO - Running setup.py (path:/tmp/pip-fPp_U8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:19:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:19:10 INFO - Running setup.py (path:/tmp/pip-MiTzd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:19:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:19:10 INFO - Running setup.py (path:/tmp/pip-FArhVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:19:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:19:10 INFO - Running setup.py (path:/tmp/pip-3YEIbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:19:11 INFO - Running setup.py (path:/tmp/pip-BBTtu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:19:11 INFO - Running setup.py (path:/tmp/pip-wFpK97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:19:11 INFO - Running setup.py (path:/tmp/pip-hS5Bx9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:19:11 INFO - Running setup.py (path:/tmp/pip-0zNC6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:19:11 INFO - Running setup.py (path:/tmp/pip-h9qbqh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:19:11 INFO - Running setup.py (path:/tmp/pip-zaMrIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:19:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:12 INFO - Downloading blessings-1.6.tar.gz 11:19:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:19:12 INFO - Installing collected packages: blessings 11:19:12 INFO - Running setup.py install for blessings 11:19:12 INFO - Successfully installed blessings 11:19:12 INFO - Cleaning up... 11:19:12 INFO - Return code: 0 11:19:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:19:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:19:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:19:13 INFO - Reading from file tmpfile_stdout 11:19:13 INFO - Current package versions: 11:19:13 INFO - argparse == 1.2.1 11:19:13 INFO - blessings == 1.6 11:19:13 INFO - blobuploader == 1.2.4 11:19:13 INFO - docopt == 0.6.1 11:19:13 INFO - functools32 == 3.2.3-2 11:19:13 INFO - jsonschema == 2.5.1 11:19:13 INFO - manifestparser == 1.1 11:19:13 INFO - mozInstall == 1.13 11:19:13 INFO - mozcrash == 1.0 11:19:13 INFO - mozdebug == 0.1 11:19:13 INFO - mozdevice == 0.51 11:19:13 INFO - mozfile == 1.2 11:19:13 INFO - mozhttpd == 0.7 11:19:13 INFO - mozinfo == 0.10 11:19:13 INFO - mozleak == 0.1 11:19:13 INFO - mozlog == 3.5 11:19:13 INFO - moznetwork == 0.27 11:19:13 INFO - mozprocess == 0.25 11:19:13 INFO - mozprofile == 0.28 11:19:13 INFO - mozrunner == 6.13 11:19:13 INFO - mozscreenshot == 0.1 11:19:13 INFO - mozsystemmonitor == 0.3 11:19:13 INFO - moztest == 0.8 11:19:13 INFO - mozversion == 1.4 11:19:13 INFO - psutil == 3.1.1 11:19:13 INFO - requests == 1.2.3 11:19:13 INFO - wsgiref == 0.1.2 11:19:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:19:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:13 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 0x21041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2470a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2474090>, '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 0x2474d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246ef90>, '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': 'ea65d483da93c827905c2090000001f5-1505153888.527711-1463032272', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:19:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:19:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:19:13 INFO - Using env: {'DISPLAY': ':0', 11:19:13 INFO - 'HOME': '/home/cltbld', 11:19:13 INFO - 'LANG': 'en_US.UTF-8', 11:19:13 INFO - 'LANGUAGE': 'en_US:en', 11:19:13 INFO - 'LOGNAME': 'cltbld', 11:19:13 INFO - 'MAIL': '/var/mail/cltbld', 11:19:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:13 INFO - 'MOZ_NO_REMOTE': '1', 11:19:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:13 INFO - 'NO_EM_RESTART': '1', 11:19:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:13 INFO - 'PWD': '/builds/slave/test', 11:19:13 INFO - 'SHELL': '/bin/bash', 11:19:13 INFO - 'SHLVL': '1', 11:19:13 INFO - 'TERM': 'linux', 11:19:13 INFO - 'TMOUT': '86400', 11:19:13 INFO - 'USER': 'cltbld', 11:19:13 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1505153888.527711-1463032272', 11:19:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:13 INFO - '_': '/tools/buildbot/bin/python'} 11:19:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:19:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:19:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:19:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:19:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:19:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:19:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:19:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:19:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:19:13 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:19:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:19:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:19:14 INFO - Installing collected packages: simplejson 11:19:14 INFO - Running setup.py install for simplejson 11:19:14 INFO - building 'simplejson._speedups' extension 11:19:14 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 11:19:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 11:19:15 INFO - Successfully installed simplejson 11:19:15 INFO - Cleaning up... 11:19:15 INFO - Return code: 0 11:19:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:19:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:15 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 0x21041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2470a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2474090>, '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 0x2474d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246ef90>, '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': 'ea65d483da93c827905c2090000001f5-1505153888.527711-1463032272', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:19:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:19:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:19:15 INFO - Using env: {'DISPLAY': ':0', 11:19:15 INFO - 'HOME': '/home/cltbld', 11:19:15 INFO - 'LANG': 'en_US.UTF-8', 11:19:15 INFO - 'LANGUAGE': 'en_US:en', 11:19:15 INFO - 'LOGNAME': 'cltbld', 11:19:15 INFO - 'MAIL': '/var/mail/cltbld', 11:19:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:15 INFO - 'MOZ_NO_REMOTE': '1', 11:19:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:15 INFO - 'NO_EM_RESTART': '1', 11:19:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:15 INFO - 'PWD': '/builds/slave/test', 11:19:15 INFO - 'SHELL': '/bin/bash', 11:19:15 INFO - 'SHLVL': '1', 11:19:15 INFO - 'TERM': 'linux', 11:19:15 INFO - 'TMOUT': '86400', 11:19:15 INFO - 'USER': 'cltbld', 11:19:15 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1505153888.527711-1463032272', 11:19:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:15 INFO - '_': '/tools/buildbot/bin/python'} 11:19:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:19:15 INFO - Cleaning up... 11:19:15 INFO - Return code: 0 11:19:15 INFO - Running post-action listener: _resource_record_post_action 11:19:15 INFO - Running post-action listener: _start_resource_monitoring 11:19:15 INFO - Starting resource monitoring. 11:19:15 INFO - [mozharness: 2017-09-11 18:19:15.718041Z] Finished create-virtualenv step (success) 11:19:15 INFO - [mozharness: 2017-09-11 18:19:15.718619Z] Running install step. 11:19:15 INFO - Running pre-action listener: _resource_record_pre_action 11:19:15 INFO - Running main action method: install 11:19:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:19:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:19:15 INFO - Reading from file tmpfile_stdout 11:19:15 INFO - Detecting whether we're running mozinstall >=1.0... 11:19:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:19:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:19:16 INFO - Reading from file tmpfile_stdout 11:19:16 INFO - Output received: 11:19:16 INFO - Usage: mozinstall [options] installer 11:19:16 INFO - Options: 11:19:16 INFO - -h, --help show this help message and exit 11:19:16 INFO - -d DEST, --destination=DEST 11:19:16 INFO - Directory to install application into. [default: 11:19:16 INFO - "/builds/slave/test"] 11:19:16 INFO - --app=APP Application being installed. [default: firefox] 11:19:16 INFO - mkdir: /builds/slave/test/build/application 11:19:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:19:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:19:32 INFO - Reading from file tmpfile_stdout 11:19:32 INFO - Output received: 11:19:32 INFO - /builds/slave/test/build/application/firefox/firefox 11:19:32 INFO - Running post-action listener: _resource_record_post_action 11:19:32 INFO - [mozharness: 2017-09-11 18:19:32.750155Z] Finished install step (success) 11:19:32 INFO - [mozharness: 2017-09-11 18:19:32.750299Z] Running setup-mitmproxy step. 11:19:32 INFO - Running pre-action listener: _resource_record_pre_action 11:19:32 INFO - Running main action method: setup_mitmproxy 11:19:32 INFO - Skipping: mitmproxy is not required 11:19:32 INFO - Running post-action listener: _resource_record_post_action 11:19:32 INFO - [mozharness: 2017-09-11 18:19:32.751351Z] Finished setup-mitmproxy step (success) 11:19:32 INFO - [mozharness: 2017-09-11 18:19:32.751571Z] Running run-tests step. 11:19:32 INFO - Running pre-action listener: _resource_record_pre_action 11:19:32 INFO - Running pre-action listener: _set_gcov_prefix 11:19:32 INFO - Running main action method: run_tests 11:19:32 WARNING - Try message not found. 11:19:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:19:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:19:32 INFO - Python 2.7.3 11:19:32 INFO - Return code: 0 11:19:32 INFO - grabbing minidump binary from tooltool 11:19:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:32 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2474090>, '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 0x2474d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246ef90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:19:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:19:32 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:19:32 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:19:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:19:32 INFO - Return code: 0 11:19:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:19:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:19:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:19:32 INFO - ENV: RUST_BACKTRACE is now full 11:19:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:19:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:19:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C8epV1-GTcmlPzW_iPUoRQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-084', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:19:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/C8epV1-GTcmlPzW_iPUoRQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-084 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:19:32 INFO - Using env: {'DISPLAY': ':0', 11:19:32 INFO - 'HOME': '/home/cltbld', 11:19:32 INFO - 'LANG': 'en_US.UTF-8', 11:19:32 INFO - 'LANGUAGE': 'en_US:en', 11:19:32 INFO - 'LOGNAME': 'cltbld', 11:19:32 INFO - 'MAIL': '/var/mail/cltbld', 11:19:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:19:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:19:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:32 INFO - 'MOZ_NO_REMOTE': '1', 11:19:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:19:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:32 INFO - 'NO_EM_RESTART': '1', 11:19:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:32 INFO - 'PWD': '/builds/slave/test', 11:19:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:19:32 INFO - 'RUST_BACKTRACE': 'full', 11:19:32 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:19:32 INFO - 'SHELL': '/bin/bash', 11:19:32 INFO - 'SHLVL': '1', 11:19:32 INFO - 'TERM': 'linux', 11:19:32 INFO - 'TMOUT': '86400', 11:19:32 INFO - 'USER': 'cltbld', 11:19:32 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1505153888.527711-1463032272', 11:19:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:32 INFO - '_': '/tools/buildbot/bin/python'} 11:19:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C8epV1-GTcmlPzW_iPUoRQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-084', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:19:33 INFO - mozversion application_buildid: 20170911172907 11:19:33 INFO - mozversion application_changeset: 02c78441c03d5d004e57596a130856861a30188a 11:19:33 INFO - mozversion application_display_name: Nightly 11:19:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:19:33 INFO - mozversion application_name: Firefox 11:19:33 INFO - mozversion application_remotingname: firefox 11:19:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:19:33 INFO - mozversion application_vendor: Mozilla 11:19:33 INFO - mozversion application_version: 57.0a1 11:19:33 INFO - mozversion platform_buildid: 20170911172907 11:19:33 INFO - mozversion platform_changeset: 02c78441c03d5d004e57596a130856861a30188a 11:19:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:19:33 INFO - mozversion platform_version: 57.0a1 11:19:33 INFO - using testdate: 1505153973 11:19:33 INFO - actual date: 1505153973 11:19:33 INFO - starting webserver on 'localhost:44998' 11:19:33 INFO - SUITE-START | Running 2 tests 11:19:33 INFO - TEST-START | dromaeo_css 11:19:33 INFO - Initialising browser for dromaeo_css test... 11:19:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44998/getInfo.html -profile /tmp/tmp86pGHd/profile 11:19:33 INFO - TEST-INFO | started process 5113 (/builds/slave/test/build/application/firefox/firefox http://localhost:44998/getInfo.html) 11:19:38 INFO - TEST-INFO | 5113: exit 0 11:19:38 INFO - Browser initialized. 11:19:38 INFO - Running cycle 1/1 for dromaeo_css test... 11:19:38 INFO - Using env: {'DISPLAY': ':0', 11:19:38 INFO - 'HOME': '/home/cltbld', 11:19:38 INFO - 'JSGC_DISABLE_POISONING': '1', 11:19:38 INFO - 'LANG': 'en_US.UTF-8', 11:19:38 INFO - 'LANGUAGE': 'en_US:en', 11:19:38 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:19:38 INFO - 'LOGNAME': 'cltbld', 11:19:38 INFO - 'MAIL': '/var/mail/cltbld', 11:19:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:19:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:19:38 INFO - 'MOZ_CRASHREPORTER': '1', 11:19:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:38 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:19:38 INFO - 'MOZ_NO_REMOTE': '1', 11:19:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:19:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:38 INFO - 'NO_EM_RESTART': '1', 11:19:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:38 INFO - 'PWD': '/builds/slave/test', 11:19:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:19:38 INFO - 'RUST_BACKTRACE': 'full', 11:19:38 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:19:38 INFO - 'SHELL': '/bin/bash', 11:19:38 INFO - 'SHLVL': '1', 11:19:38 INFO - 'TERM': 'linux', 11:19:38 INFO - 'TMOUT': '86400', 11:19:38 INFO - 'USER': 'cltbld', 11:19:38 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1505153888.527711-1463032272', 11:19:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:38 INFO - '_': '/tools/buildbot/bin/python'} 11:19:38 INFO - TEST-INFO | started process 5311 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp86pGHd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:19:39 INFO - PID 5311 | 11:19:39 INFO - PID 5311 | (/builds/slave/test/build/application/firefox/firefox:5362): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:19:39 INFO - PID 5311 | 11:19:50 INFO - PID 5311 | RSS: Main: 172982272 11:19:50 INFO - PID 5311 | 11:22:46 INFO - PID 5311 | Cycle 1(1): loaded http://localhost:44998/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44998/tests/dromaeo/cssquery-ext.html) 11:22:48 INFO - PID 5311 | RSS: Main: 174493696 11:22:48 INFO - PID 5311 | 11:25:49 INFO - PID 5311 | Cycle 1(1): loaded http://localhost:44998/tests/dromaeo/cssquery-ext.html (next: http://localhost:44998/tests/dromaeo/cssquery-jquery.html) 11:25:50 INFO - PID 5311 | RSS: Main: 171249664 11:25:50 INFO - PID 5311 | 11:28:52 INFO - PID 5311 | Cycle 1(1): loaded http://localhost:44998/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44998/tests/dromaeo/cssquery-mootools.html) 11:28:52 INFO - PID 5311 | RSS: Main: 173744128 11:28:52 INFO - PID 5311 | 11:31:54 INFO - PID 5311 | Cycle 1(1): loaded http://localhost:44998/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44998/tests/dromaeo/cssquery-prototype.html) 11:31:55 INFO - PID 5311 | RSS: Main: 171941888 11:31:55 INFO - PID 5311 | 11:34:58 INFO - PID 5311 | Cycle 1(1): loaded http://localhost:44998/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44998/tests/dromaeo/cssquery-yui.html) 11:34:58 INFO - PID 5311 | RSS: Main: 174264320 11:34:58 INFO - PID 5311 | 11:38:00 INFO - PID 5311 | Cycle 1(1): loaded http://localhost:44998/tests/dromaeo/cssquery-yui.html (next: http://localhost:44998/tests/dromaeo/cssquery-dojo.html) 11:38:00 INFO - PID 5311 | RSS: Main: 176238592 11:38:00 INFO - PID 5311 | 11:38:00 INFO - PID 5311 | __start_tp_report 11:38:00 INFO - PID 5311 | _x_x_mozilla_page_load 11:38:00 INFO - PID 5311 | _x_x_mozilla_page_load_details 11:38:00 INFO - PID 5311 | |i|pagename|runs| 11:38:00 INFO - PID 5311 | |0;dojo.html;3106.5029595264764;3135.655077941426;3154.1956801015735;3154.432202203604;3157.179133425309;6156.168917196177;6206.472449841769;6218.937810621893;6257.249130104388;6328.462080723139;6158.938410615892;6181.165542651741;6213.968930155343;6217;6254.906176407358;5712.600117991753;5744.368119506851;5755.712214389285;5778.162166485857;5834.6790926499025;5783.913241301384;5796.768129274824;5803.042497987827;5838.708064596774;5849.678267695296;141.73074677386586;5629.437056294379;5722.828315150552;5809.041508151171;5813;5606.383297837235;5613.66318020916;5675.971620141873;5738.282714660668;5771.971140144273;5663.773449062032;5697.202391665171;5727.284089488814;5742.28221472316;5767.019606666835;6133.6319820810895;6185.8144255672405;6191;6213.751449941997;6232.532560057968;6548.607083575001;6573.441257493071;6649.700763465656;6713.395794378481;6726.529142959995;6554.049662798868;6670.83322916931;6691.397774200345;6710.42961348286;6760.256371799098;6255.06174073888;6281.560290779647;6286.151369565096;6290.150829637986;6312.684365781738;6882.8967565486555;6895.620740859201;6905.896411553831;6990.09128813251;6999.23008469068;6567;6577.934220657828;6641.966790166115;6656.167979002625;6678.465722742169;6530.249021362509;6639.302873198341;6641.236257830411;6715.832104197434;6717.261101278856;6713.798586042427;6716.899246511306;6733.158355205599;6744.393004629607;6755.594664320157;6626.304238055031;6703.3296670332575;6709.731610735614;6768.932310676929;6800.149981252343;5193.68837869729;5221.503957124067;5234.18870075139;5259.868503287372;5283.682979021271;4489.820407183676;4527.162474942146;4568.428946381702;4595.264757638762;4664.137134630037;5713.085906255063;5783.913241301384;5788.9710551447815;5799.246098007232;5799.768009279666;6675.766348177791;6684;6742.9662851685425;6767.2894346093935;6779.72881084751;5625.46558076982;5737.168110623936;5759.568032397587;5813.88372232553;5827.3007239131575;5826.563007774434;5855.3851845556455;5860.443257890493;5861.5603829712945;5862.530997520274;6350.33321501245;6432.2602900667025;6481;6497;6578.407943285128;6635.767748128889;6708.463322934056;6781.050652908597;6796.456283497408;6804.081449004519;6318.715657795318;6373.171487706569;6388.96805515988;6406.295307516262;6541.08424820516;6543.901841472287;6549.31232220629;6585.440237579859;6598.934010659832;6603;6706.195256569048;6786.457083433413;6797.354251346114;6811.250762416229;6841.418479429304;6446.774362897276;6458.483321334188;6463.7737679181;6556.114924485324;6558.442532384801;6322.589031712924;6412.422881940461;6412.519061070531;6414.005829096497;6508.772192973223;6197.101420294122;6263.154474145932;6268.498520118288;6270.467010304175;6298.433141017331;6471.514636402195;6474.773382931575;6556.573822701509;6560.671966401565;6627.768028118992;6185.84535386619;6273.874522509615;6295.18162638854;6356.77751278703;6368.172137622079 11:38:00 INFO - PID 5311 | |1;ext.html;746.3320328306163;747.7270796159402;773.0800347586372;777.2887807655992;779.7660701789462;39250.80374598126;39848.40227396584;39869.80065099674;39888.80055599725;39958;36298.274034519294;36608;36608.26783464329;36634;36643.26713465729;6923.342282483169;7011.859762804741;7016.508844380895;7031.191412987495;7035.648217589126;6843.931560684379;6965.547239429447;7719.65261563231;7834.80412989677;7838.137804841492;7825.843483130334;7850.607469626524;7863.174366691501;7877.015373078365;7878.094019187781;7707.344875685573;7717.768466945972;7792.10390805059;7803.453758236926;7817.061952565672;7672.769816905502;7677.769666910001;7725.884111738328;7729.420293478011;7737.419693522952;35779.28441431183;35871.4619280711;36272.27455450903;36355.27289454223;36379;3451.3442445935443;3452.913677158091;3453.5510383650217;3453.8273086345835;3465.8960231193105;29345.70654293451;29464.41071178586;29491.262718431997;29530.409391812045;29554.408911821858;4899.828506002273;5060.342155519796;5062.291279220912;5063.77213025411;5079.31429257053;177325;178582;178771;178862;178939;45001.09997800091;45116.77441612771;45159.774201128785;45230.547694523295;45277.32084018742;46909.5309046912;47273.054538909026;47334.5266547337;47353.28970065452;47376.05247895023;14939.626509337353;15094.39622415091;15226;15237.771433428508;15257;12441.315727635067;12455.626331210078;12456.31490268044;12461;12487.625371238877;13908.4436622536;13961.092528985584;13991.16053036821;14021.579352619437;14094.295285235698;5642.915356269659;5725.541956643458;5733.713314334266;5755.942440575541;5831.620944638585;984.242133557157;989.1987490133015;991.4200192887098;1000.4347543637822;1007.8034783217203;21036.894815525826;21305.467363316042;21462.678059829115;21598.35204943854;21925.780742192692;1076.1821016027875;1092.5411327242577;1097.8078836203633;1102.8345748137845;1103.3876198709793;11366.204365694488;11436.313821170756;11480.712982175346;11624;11633.069354451623;214095;215033;215192;215362;215500;49730.751346243764;51831;54403.72798135984;54514;54542.45457545374;1408.253625578445;1417.8156839610785;1423.0465588056027;1430.7353139669194;1431.735129001159;25261.989520419713;25380.873095634404;25477.235682929542;25670.743292566836;25961.870190648926;34826.82586587152;34842;34870.12824679302;34892.82553587216;34940.65059349374;183712;183726;183858;184127;184918;29868.954586590233;30133.246668833453;30537;30543.694563054974;30583.08250752481;37597.45481243296;37998.050048749;38035.80982095183;38148.23703525969;38356;29293.26766830761;29575.85212073926;29771.702282976894;30151.396972060873;30188.69811301859;29235.269118272212;29265.26836829011;29395.265118371357;29474;29879.701202987693;32510.34979300448;32660.836695816368;32674;32779.180520486225;32864.17839553935;28780.856095719388;28912;28920.855395722887;29087.56368654514;29120;21613.68313785037;21796.91015449253;21904.561908761418;22000.33998980033;22064.156485079977 11:38:00 INFO - PID 5311 | |2;jquery.html;563.9548836093111;575.2636625119845;576.3084298841392;577.1659951370269;585.4672248254088;21073.789262107373;21766.564668706615;21813.345599632015;21813.345599632015;21873.453163670918;22605.54788904221;23539.646905296435;23947;24130.638040429407;24202.394940126505;6468.3855033771715;6632.137822083147;6639.136912201407;6639.634820084893;6639.900401493981;6164.938350616481;6554.475641948657;6641.900371494407;6642.833929151761;6660.700268487905;6347.650879201642;6351.237851457809;6352.587081839665;6356.269029061671;6358.650274234915;6353.714082866282;6360.236771587439;6360.363963603649;6363.427291543783;6364.586301890386;6318.620882747004;6524.478041756648;6533.509986750965;6535.052417399498;6535.346465353474;28304.15087547377;28672.13983580496;28717.856410717814;28722;28811.855940720372;2089.6447603907222;2107.4520624637553;2112.8415368847245;2113.228671534894;2118.629239883014;19313.51716207106;19509.609807803907;19634.410967670992;19921;19980.200791968306;2540.5300019496453;2545.923622291334;2583.4316450381075;2620.89516419343;2621.6329713840078;120822;126893;133846.3307683465;140911.29544352315;141308;19616.901915490616;19646.607067858848;20308.69536956947;20447.38657840267;21030.579388412145;40924.590754092074;40932;40934.181316373506;40973.385399219034;41044;10793.384216287475;10984.560617575367;11003.944980275208;11043.83434248487;11162.944185279184;9091.727248182566;9114.088591140966;9170.082991700776;9192.080791920755;9236.261099112055;10560;10763.83854242187;10833.729156770985;11062.612808551663;11223.438828058564;3705.962940370616;3878.728489005799;4041.474608300961;4135.421041054255;4234.640055595309;929.3773171974793;948.4925564822787;971.8396464583406;975.2393133355994;980.2403137568299;18458;18981.24075036983;19046.42860714153;19105.808941910404;19211.135498902582;1024.5235965276183;1028.1209565821264;1029.7940411917646;1037.7457522906784;1039.4646756920192;10290.279680422449;10306.690799275884;10348.482575871176;10649.574017039231;10693.465326733633;449737;450383;453346;459679;465810;112130.43934780273;116392.41803790927;118441;119320.40339798419;119504;1027.5838285494387;1068.4016950507585;1134.2117228526095;1136.534021051365;1182.6097387861985;19474.44204463668;19525.414237572895;19672.409827704618;19740.111694973475;20062.49843753918;53979;54166.18750718821;54171.458285416644;55085.724571376886;57182.14226786518;68558;68591.31408685849;68789.65605171942;68949.65525172342;69109.3089069123;19425.708614370513;19628.803711962697;19773.901130494254;19814.108365123317;19918.203271868962;22029.889850550644;22185.889070554545;22202.66695999529;22418;22523;17532.649347013245;17722.11389430549;17808.643827123644;17827.465176044738;17900.373486927896;15915.283812228246;16308;16490.670186595962;16580.419685310957;16816.243269053168;18043.729344060113;18288.634227315644;18375.540611484284;18556.536086597942;18631.068446577345;19040.238390464227;19088.33190838314;19106.33127840519;19136.564757642955;19152.329668461538;17502;17733.46799596014;17913.283468661106;18009.099545022433;18030.09849507493 11:38:00 INFO - PID 5311 | |3;mootools.html;1331.9533816316427;1373.5947895370864;1389.3122904162442;1393.3869097597062;1396.3158052554245;14776.556703298906;15204.695906081872;15430;15442.459513917016;15445.382184712626;15611.21943902806;15858.762118568202;15877.36490540377;15878.285477153528;15887.602809929758;2766.294594878308;2809.7892658050628;2811.4939310924024;2818.8026838121236;2821.4921314163444;2661.175035738927;2794.3014246438393;2795.4828356753965;2800.215939536933;2801.649793775778;2726.986365068172;2729.140320798942;2752.587111933216;2753.559430491122;2764.1431156341496;2706.120510833987;2718.184544636601;2735.8358498490156;2736.53478908585;2737.8494182819936;2567.9101231457;2582.780463660591;2586.9870650646812;2588.521123592123;2589.5338839008973;14862.777058344134;15077.246137693071;15240.085594864233;15249.542513724606;15254.313555890012;7694.9230507694765;7975.521468711896;7979.800504987422;7982.281594656451;8008.079070906862;5189.351331083614;5239.21411788231;5492.539699989022;5495.368032676253;5539.362973258087;1821.271491403436;1859.9535011624682;1875.6436277107307;1914.425672298305;1925.1336898395778;26402;26583.601245981325;26591;26719.19842404731;26721.331966700793;6645.6012639240835;7136.857262854817;7151;7383.520071195355;7444.702211911463;17072.48782536526;17244;17306.048167350666;17307.567310817078;17333.22000509955;7577.659005344773;7750.961245193738;7755.767326980087;7769.961150194326;7773.455858089993;5905.616134951214;7067.752628657972;7207.89188162178;7265.164506081763;7276.63616819157;4520.864374068783;5010.198368261061;5143.254228136974;5145.434002259748;5147.6911385317;1327.4889167670324;1378.7518246715488;1396.4972609860442;1396.804447377368;1415.2994267837487;906.6917248135666;926.9165775080276;930.7393929699695;931.9813603727888;936.9437833729997;8272.793180170544;8493.405461617751;8599.484030958163;8619.310455163572;8676.47941123522;939.8684184214216;969.8351280282369;989.4211886046743;999.9900001000043;1020.7754294055296;5117.462666419972;5164.3802743671;5178.860650656849;5354.116570765858;5682.176084467729;21321;21861.890690546446;22116.115355385926;22167.667484987738;22199.556008879732;20550.38348849537;21377.358679239336;21685.89157054236;21699;21741.78258217429;11099.667009989713;11254.930781575737;11302.15233857464;11413.315201087962;11463.312201267783;8525.44584601999;8557.657693692432;8593.91406085956;8614.009388920103;8662.653493860174;18015.459536213933;18832;18836.52908677294;19069.14188861477;19193.98463161348;18310.90844545822;19233.326833560757;19245.03774811282;19984;20000.599987999867;10935.28920620157;11055.115590752559;11069.335839849313;11084.390358530036;11102.389368584805;11879.703007424883;13921.095128816594;13921.373538190603;14130.293485325486;14273.357698903781;10171.542280597243;10325.896741032493;10371.688849334532;10393.06462418386;10399.740006499898;11139.777204456028;11148.944255278671;11344.716382090513;11397.601083962021;11497.1377146716;9183.678571249975;9297;9391.906080939376;9429.764255893657;9439.056094390506;6701.149081631807;6816.727330906907;6909.619970901648;6932.549384290005;7011.649417529001;7358;7376.409887209118;7418.961345411539;7425.9628701856145;7545.811354716176 11:38:00 INFO - PID 5311 | |4;prototype.html;472.56287933661355;493.7975430073668;506.98986020279597;507.99417154035;524.5619907377339;6256.119247906976;6295.426143464134;6362.650054247015;6454.806355809327;6463.289038205794;6264.530160237978;6286.811395658137;6311.589746666464;6335.651539165344;6342.556021078526;5214.634975551713;5225.320708307924;5248.71132087735;5250.9474905250845;5262.2632831403635;4877.804887804484;4934.4325402578625;5049.192129259319;5203.271541984125;5235.476452354753;4953.628477864175;4954.43024052235;4969.304297398367;4981.139616796975;5008.348914641109;4957.628177886655;4967.40391153064;4974.5624643924575;5008.574271186935;5018.222175562793;4420.513743488214;4424;4451.666125040635;4454.752669252614;4475.753833539154;6055.939440605582;6109.480694141003;6121.530832600189;6145.201123853915;6212.596181248205;5663.66018038919;5687.317521897398;5712.800571779853;5738.139279108125;5764.625299355528;6514.283428822826;6537.836554086186;6584.489624607111;6601.3728695773825;6654.201495820533;4641.628669706415;4878.804847806084;4887.1147437786685;4904.779284932187;4934.185859333205;6678.499112566528;6724.260331363546;6943.201531823804;7020.964895175492;7023.82440438988;5392.815909556636;5401.540869026098;5414.972925135349;5484.177373394023;5504.504594586427;5486.643368181056;5529;5544.611877168641;5553;5590.413006634326;5929.258842644669;6047.9739287339235;6057.212562366953;6079.939200607937;6082.635041897501;6718;6784.525083244224;6785.253622101565;6800.557963732342;6839.1451068616425;1925.4801203674929;1931.744366161978;1951.6096780643645;1954.5602239496;1957.9902100489692;1370.1436602123672;1432.3339647064165;1439.1293267572967;1452.9200893950722;1462.8829693624484;5693.829185124453;5706.743196556165;5758.222639943638;5794.362620111784;5806.767729290866;6704.167374384317;6794.564348521163;6823.215330236987;6835.453163746888;6845.8973115403305;5675.31896172462;5748.895596377993;5790.594658373873;5807.751333463326;5813.970930145322;3543.2382037861466;3578.177019285527;3596.6692323839825;3628.0748409155494;3662.2675464907124;6512.590341573648;6519.706613202417;6567.8358041048405;6570.408663220333;6572.8356791080605;6892.555460644314;6946.270641582662;6959.807660586899;7012.9298707013295;7053.259407762213;6497.011374767565;6504.284528701839;6568.343165683394;6606.6036037837885;6614.603123812587;6735.562188457735;6821.93178068213;6827.863442731018;6878.484113691393;6898.758543450955;6716.966415167893;6736.326367363225;6773;6804.4216241620015;6814.182298124257;6461.160049193575;6579.374959378852;6596.373344532261;6612.90080648781;6680.528204564148;5481.12302031689;5507.531859791962;5514.393416724077;5526.917096243479;5531.585131115102;6516.100335350723;6606.900896486461;6743.393094621508;6844.863102738017;6872.518923675495;6512.544121911421;6528.967355163384;6538.248101468392;6540.201444602772;6619.702113404812;6480.477087884249;6548.148740663683;6552.770653027312;6602;6616.702248398929;6251.9687401562705;6344.175257216532;6385.265694445198;6394.776182833579;6453.709583068679;6484.157059582224;6534.575252608565;6663.800085997428;6693.631850248283;6733.057371968026;6371.426571608577;6378.619331754177;6384.361563843579;6443.355664433519;6498.220213574401 11:38:00 INFO - PID 5311 | |5;yui.html;893.3523195683134;917.6008436330196;927.0682963621559;932.1889955738509;942.5051847779916;18780.154893029812;19890.303839365624;19904.60190796183;19936.60126797463;19955.900220498912;17345.39291124811;17706.734398984026;17851.91074044628;18258.817411825912;18411.171497282656;986.9259805514579;988.4217732626422;988.9357191782547;989.8267803134459;995.2635050062974;956.8229877472655;990.7770751580908;992.5632721602508;996;999.5901680311074;1056.4400867540178;1056.6248981611532;1056.75166335911;1057.9682609521726;1058.4866339825178;1052.0321304399931;1053.5417093564324;1053.6628278950739;1055.0873494427342;1055.5777688924416;774.8217909880702;775.2054144501931;775.3487070860505;775.5656832174001;776.1772521127623;19691.704624430644;19830.305939292055;19935.900320498306;19954.900225498925;19974;20747.481312967295;20785.480362990897;21413.250536231313;21453.67819482709;21483.570328593498;17544.736828947574;17610.295588176457;17667.911660441616;17695;17714.557136071573;3712.424574191005;3733.533308336458;3755.7183211259266;3777.471154038437;3780.8865734028022;138517;140815;141564.29217853947;142550;144619;16199.433019844484;16242.10668413225;16254.837451625568;16518.091504967102;16521.91739041297;30009.549856752164;30741.538876916864;30805.45972701356;30812.691873081432;30825;8546.145385461528;8561.828763424697;8665.913340866511;8676.34927380449;8742.56287185651;4053.1488387438967;4106.1992911382595;4107.979460102681;4122.91754164915;4125.463689720377;5338.492843179892;5442.074847275972;5443.673379597158;5446.101393270066;5447.101228297287;943.2077055273465;995.4723996281982;996.3673067602125;997.8104160209537;998.9800203996025;685.5680921019725;701.1411021498624;705.7529864547367;709.6593635055202;720.0135813934943;11678.416079196006;12179.512819487121;12563.87436125627;12690.80963785544;12803.487860485477;668.6823758714571;682.7610336382227;690.2407351912856;690.5821977703517;692.4529621598981;5593.664380137205;5703.54371650267;5722.599418040781;5750;5903.881922361528;114350.42824785823;116433;116602.41698791452;119862;122050;100704;101830;103188.48405757923;103229.48385258026;104844.47577762062;89862.55068724614;93061.53469232746;93470.0652993475;94249.52875235579;95204.52397737966;10539.57841686324;10741.570337186426;10744.946275268574;10790.244682872437;10867.782644347228;44772.55227447814;44837.32744008777;45040.648780536634;45771.31343029791;45803;55415.72292138675;56388.71805640945;56489;57104;57333.71333143308;14665.706685866437;14868;15061.472848450252;15074.170920599472;15090;15693.843061569694;15993.760093598372;16050.839491605402;16051.598710032342;16056.518304450885;13603.591892243248;13664;13695.931520342732;13708.794368084287;13839.446422143;15975.201239937724;15997.440089596808;16157.4344897928;16172.514824555283;16212.35150593963;15326.770098448755;15642.374305027672;15668.68662626764;15775.29011194522;15863.127527986071;10889.782204356026;11046.502907369348;11079.83380249313;11163.665090047312;11332.830007549728;10618.628348007782;10694.839577406501;10750.731231718957;10841.07850832688;10891.78216435651 11:38:00 INFO - PID 5311 | __end_tp_report 11:38:00 INFO - PID 5311 | __start_cc_report 11:38:00 INFO - PID 5311 | _x_x_mozilla_cycle_collect,378 11:38:00 INFO - PID 5311 | __end_cc_report 11:38:00 INFO - PID 5311 | __startTimestamp1505155080745__endTimestamp 11:38:00 INFO - PID 5311 | 11:38:00 INFO - PID 5311 | ------- Summary: start ------- 11:38:00 INFO - PID 5311 | Number of tests: 6 11:38:00 INFO - PID 5311 | 11:38:00 INFO - PID 5311 | [#0] dojo.html Cycles:165 Average:6107.59 Median:6318.72 stddev:871.95 (13.8%) stddev-sans-first:842.24 11:38:00 INFO - PID 5311 | Values: 3106.5 3135.7 3154.2 3154.4 3157.2 6156.2 6206.5 6218.9 6257.2 6328.5 6158.9 6181.2 6214.0 6217.0 6254.9 5712.6 5744.4 5755.7 5778.2 5834.7 5783.9 5796.8 5803.0 5838.7 5849.7 141.7 5629.4 5722.8 5809.0 5813.0 5606.4 5613.7 5676.0 5738.3 5772.0 5663.8 5697.2 5727.3 5742.3 5767.0 6133.6 6185.8 6191.0 6213.8 6232.5 6548.6 6573.4 6649.7 6713.4 6726.5 6554.0 6670.8 6691.4 6710.4 6760.3 6255.1 6281.6 6286.2 6290.2 6312.7 6882.9 6895.6 6905.9 6990.1 6999.2 6567.0 6577.9 6642.0 6656.2 6678.5 6530.2 6639.3 6641.2 6715.8 6717.3 6713.8 6716.9 6733.2 6744.4 6755.6 6626.3 6703.3 6709.7 6768.9 6800.1 5193.7 5221.5 5234.2 5259.9 5283.7 4489.8 4527.2 4568.4 4595.3 4664.1 5713.1 5783.9 5789.0 5799.2 5799.8 6675.8 6684.0 6743.0 6767.3 6779.7 5625.5 5737.2 5759.6 5813.9 5827.3 5826.6 5855.4 5860.4 5861.6 5862.5 6350.3 6432.3 6481.0 6497.0 6578.4 6635.8 6708.5 6781.1 6796.5 6804.1 6318.7 6373.2 6389.0 6406.3 6541.1 6543.9 6549.3 6585.4 6598.9 6603.0 6706.2 6786.5 6797.4 6811.3 6841.4 6446.8 6458.5 6463.8 6556.1 6558.4 6322.6 6412.4 6412.5 6414.0 6508.8 6197.1 6263.2 6268.5 6270.5 6298.4 6471.5 6474.8 6556.6 6560.7 6627.8 6185.8 6273.9 6295.2 6356.8 6368.2 11:38:00 INFO - PID 5311 | 11:38:00 INFO - PID 5311 | [#1] ext.html Cycles:180 Average:35204.82 Median:32821.68 stddev:49987.50 (152.3%) stddev-sans-first:50060.77 11:38:00 INFO - PID 5311 | Values: 746.3 747.7 773.1 777.3 779.8 39250.8 39848.4 39869.8 39888.8 39958.0 36298.3 36608.0 36608.3 36634.0 36643.3 6923.3 7011.9 7016.5 7031.2 7035.6 6843.9 6965.5 7719.7 7834.8 7838.1 7825.8 7850.6 7863.2 7877.0 7878.1 7707.3 7717.8 7792.1 7803.5 7817.1 7672.8 7677.8 7725.9 7729.4 7737.4 35779.3 35871.5 36272.3 36355.3 36379.0 3451.3 3452.9 3453.6 3453.8 3465.9 29345.7 29464.4 29491.3 29530.4 29554.4 4899.8 5060.3 5062.3 5063.8 5079.3 177325.0 178582.0 178771.0 178862.0 178939.0 45001.1 45116.8 45159.8 45230.5 45277.3 46909.5 47273.1 47334.5 47353.3 47376.1 14939.6 15094.4 15226.0 15237.8 15257.0 12441.3 12455.6 12456.3 12461.0 12487.6 13908.4 13961.1 13991.2 14021.6 14094.3 5642.9 5725.5 5733.7 5755.9 5831.6 984.2 989.2 991.4 1000.4 1007.8 21036.9 21305.5 21462.7 21598.4 21925.8 1076.2 1092.5 1097.8 1102.8 1103.4 11366.2 11436.3 11480.7 11624.0 11633.1 214095.0 215033.0 215192.0 215362.0 215500.0 49730.8 51831.0 54403.7 54514.0 54542.5 1408.3 1417.8 1423.0 1430.7 1431.7 25262.0 25380.9 25477.2 25670.7 25961.9 34826.8 34842.0 34870.1 34892.8 34940.7 183712.0 183726.0 183858.0 184127.0 184918.0 29869.0 30133.2 30537.0 30543.7 30583.1 37597.5 37998.1 38035.8 38148.2 38356.0 29293.3 29575.9 29771.7 30151.4 30188.7 29235.3 29265.3 29395.3 29474.0 29879.7 32510.3 32660.8 32674.0 32779.2 32864.2 28780.9 28912.0 28920.9 29087.6 29120.0 21613.7 21796.9 21904.6 22000.3 22064.2 11:38:00 INFO - PID 5311 | 11:38:00 INFO - PID 5311 | [#2] jquery.html Cycles:180 Average:34461.62 Median:11942.60 stddev:77032.51 (645.0%) stddev-sans-first:77206.56 11:38:00 INFO - PID 5311 | Values: 564.0 575.3 576.3 577.2 585.5 21073.8 21766.6 21813.3 21813.3 21873.5 22605.5 23539.6 23947.0 24130.6 24202.4 6468.4 6632.1 6639.1 6639.6 6639.9 6164.9 6554.5 6641.9 6642.8 6660.7 6347.7 6351.2 6352.6 6356.3 6358.7 6353.7 6360.2 6360.4 6363.4 6364.6 6318.6 6524.5 6533.5 6535.1 6535.3 28304.2 28672.1 28717.9 28722.0 28811.9 2089.6 2107.5 2112.8 2113.2 2118.6 19313.5 19509.6 19634.4 19921.0 19980.2 2540.5 2545.9 2583.4 2620.9 2621.6 120822.0 126893.0 133846.3 140911.3 141308.0 19616.9 19646.6 20308.7 20447.4 21030.6 40924.6 40932.0 40934.2 40973.4 41044.0 10793.4 10984.6 11003.9 11043.8 11162.9 9091.7 9114.1 9170.1 9192.1 9236.3 10560.0 10763.8 10833.7 11062.6 11223.4 3706.0 3878.7 4041.5 4135.4 4234.6 929.4 948.5 971.8 975.2 980.2 18458.0 18981.2 19046.4 19105.8 19211.1 1024.5 1028.1 1029.8 1037.7 1039.5 10290.3 10306.7 10348.5 10649.6 10693.5 449737.0 450383.0 453346.0 459679.0 465810.0 112130.4 116392.4 118441.0 119320.4 119504.0 1027.6 1068.4 1134.2 1136.5 1182.6 19474.4 19525.4 19672.4 19740.1 20062.5 53979.0 54166.2 54171.5 55085.7 57182.1 68558.0 68591.3 68789.7 68949.7 69109.3 19425.7 19628.8 19773.9 19814.1 19918.2 22029.9 22185.9 22202.7 22418.0 22523.0 17532.6 17722.1 17808.6 17827.5 17900.4 15915.3 16308.0 16490.7 16580.4 16816.2 18043.7 18288.6 18375.5 18556.5 18631.1 19040.2 19088.3 19106.3 19136.6 19152.3 17502.0 17733.5 17913.3 18009.1 18030.1 11:38:00 INFO - PID 5311 | 11:38:00 INFO - PID 5311 | [#3] mootools.html Cycles:180 Average:9321.37 Median:26720.27 stddev:6718.96 (25.1%) stddev-sans-first:6711.00 11:38:00 INFO - PID 5311 | Values: 1332.0 1373.6 1389.3 1393.4 1396.3 14776.6 15204.7 15430.0 15442.5 15445.4 15611.2 15858.8 15877.4 15878.3 15887.6 2766.3 2809.8 2811.5 2818.8 2821.5 2661.2 2794.3 2795.5 2800.2 2801.6 2727.0 2729.1 2752.6 2753.6 2764.1 2706.1 2718.2 2735.8 2736.5 2737.8 2567.9 2582.8 2587.0 2588.5 2589.5 14862.8 15077.2 15240.1 15249.5 15254.3 7694.9 7975.5 7979.8 7982.3 8008.1 5189.4 5239.2 5492.5 5495.4 5539.4 1821.3 1860.0 1875.6 1914.4 1925.1 26402.0 26583.6 26591.0 26719.2 26721.3 6645.6 7136.9 7151.0 7383.5 7444.7 17072.5 17244.0 17306.0 17307.6 17333.2 7577.7 7751.0 7755.8 7770.0 7773.5 5905.6 7067.8 7207.9 7265.2 7276.6 4520.9 5010.2 5143.3 5145.4 5147.7 1327.5 1378.8 1396.5 1396.8 1415.3 906.7 926.9 930.7 932.0 936.9 8272.8 8493.4 8599.5 8619.3 8676.5 939.9 969.8 989.4 1000.0 1020.8 5117.5 5164.4 5178.9 5354.1 5682.2 21321.0 21861.9 22116.1 22167.7 22199.6 20550.4 21377.4 21685.9 21699.0 21741.8 11099.7 11254.9 11302.2 11413.3 11463.3 8525.4 8557.7 8593.9 8614.0 8662.7 18015.5 18832.0 18836.5 19069.1 19194.0 18310.9 19233.3 19245.0 19984.0 20000.6 10935.3 11055.1 11069.3 11084.4 11102.4 11879.7 13921.1 13921.4 14130.3 14273.4 10171.5 10325.9 10371.7 10393.1 10399.7 11139.8 11148.9 11344.7 11397.6 11497.1 9183.7 9297.0 9391.9 9429.8 9439.1 6701.1 6816.7 6909.6 6932.5 7011.6 7358.0 7376.4 7419.0 7426.0 7545.8 11:38:00 INFO - PID 5311 | 11:38:00 INFO - PID 5311 | [#4] prototype.html Cycles:180 Average:5614.96 Median:6254.04 stddev:1531.59 (24.5%) stddev-sans-first:1486.46 11:38:00 INFO - PID 5311 | Values: 472.6 493.8 507.0 508.0 524.6 6256.1 6295.4 6362.7 6454.8 6463.3 6264.5 6286.8 6311.6 6335.7 6342.6 5214.6 5225.3 5248.7 5250.9 5262.3 4877.8 4934.4 5049.2 5203.3 5235.5 4953.6 4954.4 4969.3 4981.1 5008.3 4957.6 4967.4 4974.6 5008.6 5018.2 4420.5 4424.0 4451.7 4454.8 4475.8 6055.9 6109.5 6121.5 6145.2 6212.6 5663.7 5687.3 5712.8 5738.1 5764.6 6514.3 6537.8 6584.5 6601.4 6654.2 4641.6 4878.8 4887.1 4904.8 4934.2 6678.5 6724.3 6943.2 7021.0 7023.8 5392.8 5401.5 5415.0 5484.2 5504.5 5486.6 5529.0 5544.6 5553.0 5590.4 5929.3 6048.0 6057.2 6079.9 6082.6 6718.0 6784.5 6785.3 6800.6 6839.1 1925.5 1931.7 1951.6 1954.6 1958.0 1370.1 1432.3 1439.1 1452.9 1462.9 5693.8 5706.7 5758.2 5794.4 5806.8 6704.2 6794.6 6823.2 6835.5 6845.9 5675.3 5748.9 5790.6 5807.8 5814.0 3543.2 3578.2 3596.7 3628.1 3662.3 6512.6 6519.7 6567.8 6570.4 6572.8 6892.6 6946.3 6959.8 7012.9 7053.3 6497.0 6504.3 6568.3 6606.6 6614.6 6735.6 6821.9 6827.9 6878.5 6898.8 6717.0 6736.3 6773.0 6804.4 6814.2 6461.2 6579.4 6596.4 6612.9 6680.5 5481.1 5507.5 5514.4 5526.9 5531.6 6516.1 6606.9 6743.4 6844.9 6872.5 6512.5 6529.0 6538.2 6540.2 6619.7 6480.5 6548.1 6552.8 6602.0 6616.7 6252.0 6344.2 6385.3 6394.8 6453.7 6484.2 6534.6 6663.8 6693.6 6733.1 6371.4 6378.6 6384.4 6443.4 6498.2 11:38:00 INFO - PID 5311 | 11:38:00 INFO - PID 5311 | [#5] yui.html Cycles:180 Average:23824.04 Median:19936.25 stddev:34632.37 (173.7%) stddev-sans-first:34686.73 11:38:00 INFO - PID 5311 | Values: 893.4 917.6 927.1 932.2 942.5 18780.2 19890.3 19904.6 19936.6 19955.9 17345.4 17706.7 17851.9 18258.8 18411.2 986.9 988.4 988.9 989.8 995.3 956.8 990.8 992.6 996.0 999.6 1056.4 1056.6 1056.8 1058.0 1058.5 1052.0 1053.5 1053.7 1055.1 1055.6 774.8 775.2 775.3 775.6 776.2 19691.7 19830.3 19935.9 19954.9 19974.0 20747.5 20785.5 21413.3 21453.7 21483.6 17544.7 17610.3 17667.9 17695.0 17714.6 3712.4 3733.5 3755.7 3777.5 3780.9 138517.0 140815.0 141564.3 142550.0 144619.0 16199.4 16242.1 16254.8 16518.1 16521.9 30009.5 30741.5 30805.5 30812.7 30825.0 8546.1 8561.8 8665.9 8676.3 8742.6 4053.1 4106.2 4108.0 4122.9 4125.5 5338.5 5442.1 5443.7 5446.1 5447.1 943.2 995.5 996.4 997.8 999.0 685.6 701.1 705.8 709.7 720.0 11678.4 12179.5 12563.9 12690.8 12803.5 668.7 682.8 690.2 690.6 692.5 5593.7 5703.5 5722.6 5750.0 5903.9 114350.4 116433.0 116602.4 119862.0 122050.0 100704.0 101830.0 103188.5 103229.5 104844.5 89862.6 93061.5 93470.1 94249.5 95204.5 10539.6 10741.6 10744.9 10790.2 10867.8 44772.6 44837.3 45040.6 45771.3 45803.0 55415.7 56388.7 56489.0 57104.0 57333.7 14665.7 14868.0 15061.5 15074.2 15090.0 15693.8 15993.8 16050.8 16051.6 16056.5 13603.6 13664.0 13695.9 13708.8 13839.4 15975.2 15997.4 16157.4 16172.5 16212.4 15326.8 15642.4 15668.7 15775.3 15863.1 10889.8 11046.5 11079.8 11163.7 11332.8 10618.6 10694.8 10750.7 10841.1 10891.8 11:38:00 INFO - PID 5311 | -------- Summary: end -------- 11:38:00 INFO - PID 5311 | 11:38:01 INFO - TEST-INFO | 5311: exit 0 11:38:01 INFO - TEST-OK | dromaeo_css | took 1108334ms 11:38:01 INFO - TEST-START | kraken 11:38:01 INFO - Initialising browser for kraken test... 11:38:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44998/getInfo.html -profile /tmp/tmpEJxChm/profile 11:38:01 INFO - TEST-INFO | started process 5691 (/builds/slave/test/build/application/firefox/firefox http://localhost:44998/getInfo.html) 11:38:07 INFO - TEST-INFO | 5691: exit 0 11:38:07 INFO - Browser initialized. 11:38:07 INFO - Running cycle 1/1 for kraken test... 11:38:07 INFO - Using env: {'DISPLAY': ':0', 11:38:07 INFO - 'HOME': '/home/cltbld', 11:38:07 INFO - 'JSGC_DISABLE_POISONING': '1', 11:38:07 INFO - 'LANG': 'en_US.UTF-8', 11:38:07 INFO - 'LANGUAGE': 'en_US:en', 11:38:07 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:38:07 INFO - 'LOGNAME': 'cltbld', 11:38:07 INFO - 'MAIL': '/var/mail/cltbld', 11:38:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:38:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:38:07 INFO - 'MOZ_CRASHREPORTER': '1', 11:38:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:07 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:38:07 INFO - 'MOZ_NO_REMOTE': '1', 11:38:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:38:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:38:07 INFO - 'NO_EM_RESTART': '1', 11:38:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:38:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:07 INFO - 'PWD': '/builds/slave/test', 11:38:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:38:07 INFO - 'RUST_BACKTRACE': 'full', 11:38:07 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:38:07 INFO - 'SHELL': '/bin/bash', 11:38:07 INFO - 'SHLVL': '1', 11:38:07 INFO - 'TERM': 'linux', 11:38:07 INFO - 'TMOUT': '86400', 11:38:07 INFO - 'USER': 'cltbld', 11:38:07 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1505153888.527711-1463032272', 11:38:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:07 INFO - '_': '/tools/buildbot/bin/python'} 11:38:07 INFO - TEST-INFO | started process 5889 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEJxChm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:38:08 INFO - PID 5889 | 11:38:08 INFO - PID 5889 | (/builds/slave/test/build/application/firefox/firefox:5940): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:38:08 INFO - PID 5889 | 11:38:18 INFO - PID 5889 | RSS: Main: 167518208 11:38:18 INFO - PID 5889 | 11:38:21 INFO - PID 5889 | Cycle 1(1): loaded http://localhost:44998/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44998/tests/kraken/driver.html?testName=audio-beat-detection) 11:38:22 INFO - PID 5889 | RSS: Main: 172285952 11:38:22 INFO - PID 5889 | 11:38:25 INFO - PID 5889 | Cycle 1(1): loaded http://localhost:44998/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44998/tests/kraken/driver.html?testName=audio-dft) 11:38:25 INFO - PID 5889 | RSS: Main: 173080576 11:38:25 INFO - PID 5889 | 11:38:28 INFO - PID 5889 | Cycle 1(1): loaded http://localhost:44998/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44998/tests/kraken/driver.html?testName=audio-fft) 11:38:29 INFO - PID 5889 | RSS: Main: 168304640 11:38:29 INFO - PID 5889 | 11:38:31 INFO - PID 5889 | Cycle 1(1): loaded http://localhost:44998/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44998/tests/kraken/driver.html?testName=audio-oscillator) 11:38:31 INFO - PID 5889 | RSS: Main: 168808448 11:38:31 INFO - PID 5889 | 11:38:34 INFO - PID 5889 | Cycle 1(1): loaded http://localhost:44998/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44998/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:38:34 INFO - PID 5889 | RSS: Main: 168853504 11:38:34 INFO - PID 5889 | 11:38:37 INFO - PID 5889 | Cycle 1(1): loaded http://localhost:44998/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44998/tests/kraken/driver.html?testName=imaging-darkroom) 11:38:38 INFO - PID 5889 | RSS: Main: 171642880 11:38:38 INFO - PID 5889 | 11:38:42 INFO - PID 5889 | Cycle 1(1): loaded http://localhost:44998/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44998/tests/kraken/driver.html?testName=imaging-desaturate) 11:38:42 INFO - PID 5889 | RSS: Main: 172023808 11:38:42 INFO - PID 5889 | 11:38:45 INFO - PID 5889 | Cycle 1(1): loaded http://localhost:44998/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44998/tests/kraken/driver.html?testName=json-parse-financial) 11:38:46 INFO - PID 5889 | RSS: Main: 172056576 11:38:46 INFO - PID 5889 | 11:38:47 INFO - PID 5889 | Cycle 1(1): loaded http://localhost:44998/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44998/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:38:48 INFO - PID 5889 | RSS: Main: 172044288 11:38:48 INFO - PID 5889 | 11:38:50 INFO - PID 5889 | Cycle 1(1): loaded http://localhost:44998/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44998/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:38:50 INFO - PID 5889 | RSS: Main: 172306432 11:38:50 INFO - PID 5889 | 11:38:52 INFO - PID 5889 | Cycle 1(1): loaded http://localhost:44998/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44998/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:38:53 INFO - PID 5889 | RSS: Main: 172384256 11:38:53 INFO - PID 5889 | 11:38:56 INFO - PID 5889 | Cycle 1(1): loaded http://localhost:44998/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44998/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:38:56 INFO - PID 5889 | RSS: Main: 173084672 11:38:56 INFO - PID 5889 | 11:38:59 INFO - PID 5889 | Cycle 1(1): loaded http://localhost:44998/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44998/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:39:00 INFO - PID 5889 | RSS: Main: 173142016 11:39:00 INFO - PID 5889 | 11:39:02 INFO - PID 5889 | Cycle 1(1): loaded http://localhost:44998/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44998/tests/kraken/driver.html?testName=ai-astar) 11:39:02 INFO - PID 5889 | RSS: Main: 174362624 11:39:02 INFO - PID 5889 | 11:39:02 INFO - PID 5889 | __start_tp_report 11:39:02 INFO - PID 5889 | _x_x_mozilla_page_load 11:39:02 INFO - PID 5889 | _x_x_mozilla_page_load_details 11:39:02 INFO - PID 5889 | |i|pagename|runs| 11:39:02 INFO - PID 5889 | |0;ai-astar;109;105;108;106;108;99;109;107;107;109 11:39:02 INFO - PID 5889 | |1;audio-beat-detection;117;114;115;121;121;151;118;117;119;116 11:39:02 INFO - PID 5889 | |2;audio-dft;163;163;163;163;162;164;164;172;164;164 11:39:02 INFO - PID 5889 | |3;audio-fft;73;73;73;74;73;75;84;76;73;74 11:39:02 INFO - PID 5889 | |4;audio-oscillator;80;79;78;79;78;78;78;88;86;79 11:39:02 INFO - PID 5889 | |5;imaging-gaussian-blur;113;113;112;114;113;113;113;113;114;115 11:39:02 INFO - PID 5889 | |6;imaging-darkroom;148;147;147;147;147;146;147;148;149;148 11:39:02 INFO - PID 5889 | |7;imaging-desaturate;93;94;94;94;93;94;99;97;95;95 11:39:02 INFO - PID 5889 | |8;json-parse-financial;54;52;52;52;54;52;52;52;59;49 11:39:02 INFO - PID 5889 | |9;json-stringify-tinderbox;38;39;38;39;38;38;38;38;38;39 11:39:02 INFO - PID 5889 | |10;stanford-crypto-aes;74;75;75;76;75;78;78;75;77;85 11:39:02 INFO - PID 5889 | |11;stanford-crypto-ccm;127;124;120;120;120;124;123;118;124;121 11:39:02 INFO - PID 5889 | |12;stanford-crypto-pbkdf2;178;173;185;168;169;187;176;171;171;170 11:39:02 INFO - PID 5889 | |13;stanford-crypto-sha256-iterative;68;71;64;63;66;66;65;64;68;68 11:39:02 INFO - PID 5889 | __end_tp_report 11:39:02 INFO - PID 5889 | __start_cc_report 11:39:02 INFO - PID 5889 | _x_x_mozilla_cycle_collect,920 11:39:02 INFO - PID 5889 | __end_cc_report 11:39:02 INFO - PID 5889 | __startTimestamp1505155142679__endTimestamp 11:39:02 INFO - PID 5889 | 11:39:02 INFO - PID 5889 | ------- Summary: start ------- 11:39:02 INFO - PID 5889 | Number of tests: 14 11:39:02 INFO - PID 5889 | 11:39:02 INFO - PID 5889 | [#0] ai-astar Cycles:10 Average:106.70 Median:108.50 stddev:3.02 (2.8%) stddev-sans-first:3.09 11:39:02 INFO - PID 5889 | Values: 109.0 105.0 108.0 106.0 108.0 99.0 109.0 107.0 107.0 109.0 11:39:02 INFO - PID 5889 | 11:39:02 INFO - PID 5889 | [#1] audio-beat-detection Cycles:10 Average:120.90 Median:118.50 stddev:10.83 (9.1%) stddev-sans-first:11.39 11:39:02 INFO - PID 5889 | Values: 117.0 114.0 115.0 121.0 121.0 151.0 118.0 117.0 119.0 116.0 11:39:02 INFO - PID 5889 | 11:39:02 INFO - PID 5889 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.00 stddev:2.82 (1.7%) stddev-sans-first:2.96 11:39:02 INFO - PID 5889 | Values: 163.0 163.0 163.0 163.0 162.0 164.0 164.0 172.0 164.0 164.0 11:39:02 INFO - PID 5889 | 11:39:02 INFO - PID 5889 | [#3] audio-fft Cycles:10 Average:74.80 Median:74.00 stddev:3.39 (4.6%) stddev-sans-first:3.54 11:39:02 INFO - PID 5889 | Values: 73.0 73.0 73.0 74.0 73.0 75.0 84.0 76.0 73.0 74.0 11:39:02 INFO - PID 5889 | 11:39:02 INFO - PID 5889 | [#4] audio-oscillator Cycles:10 Average:80.30 Median:79.00 stddev:3.62 (4.6%) stddev-sans-first:3.84 11:39:02 INFO - PID 5889 | Values: 80.0 79.0 78.0 79.0 78.0 78.0 78.0 88.0 86.0 79.0 11:39:02 INFO - PID 5889 | 11:39:02 INFO - PID 5889 | [#5] imaging-gaussian-blur Cycles:10 Average:113.30 Median:113.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 11:39:02 INFO - PID 5889 | Values: 113.0 113.0 112.0 114.0 113.0 113.0 113.0 113.0 114.0 115.0 11:39:02 INFO - PID 5889 | 11:39:02 INFO - PID 5889 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 11:39:02 INFO - PID 5889 | Values: 148.0 147.0 147.0 147.0 147.0 146.0 147.0 148.0 149.0 148.0 11:39:02 INFO - PID 5889 | 11:39:02 INFO - PID 5889 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:94.50 stddev:1.87 (2.0%) stddev-sans-first:1.87 11:39:02 INFO - PID 5889 | Values: 93.0 94.0 94.0 94.0 93.0 94.0 99.0 97.0 95.0 95.0 11:39:02 INFO - PID 5889 | 11:39:02 INFO - PID 5889 | [#8] json-parse-financial Cycles:10 Average:52.80 Median:52.00 stddev:2.57 (4.9%) stddev-sans-first:2.69 11:39:02 INFO - PID 5889 | Values: 54.0 52.0 52.0 52.0 54.0 52.0 52.0 52.0 59.0 49.0 11:39:02 INFO - PID 5889 | 11:39:02 INFO - PID 5889 | [#9] json-stringify-tinderbox Cycles:10 Average:38.30 Median:38.00 stddev:0.48 (1.3%) stddev-sans-first:0.50 11:39:02 INFO - PID 5889 | Values: 38.0 39.0 38.0 39.0 38.0 38.0 38.0 38.0 38.0 39.0 11:39:02 INFO - PID 5889 | 11:39:02 INFO - PID 5889 | [#10] stanford-crypto-aes Cycles:10 Average:76.80 Median:76.50 stddev:3.19 (4.2%) stddev-sans-first:3.22 11:39:02 INFO - PID 5889 | Values: 74.0 75.0 75.0 76.0 75.0 78.0 78.0 75.0 77.0 85.0 11:39:02 INFO - PID 5889 | 11:39:02 INFO - PID 5889 | [#11] stanford-crypto-ccm Cycles:10 Average:122.10 Median:123.50 stddev:2.73 (2.2%) stddev-sans-first:2.24 11:39:02 INFO - PID 5889 | Values: 127.0 124.0 120.0 120.0 120.0 124.0 123.0 118.0 124.0 121.0 11:39:02 INFO - PID 5889 | 11:39:02 INFO - PID 5889 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.80 Median:174.50 stddev:6.66 (3.8%) stddev-sans-first:6.97 11:39:02 INFO - PID 5889 | Values: 178.0 173.0 185.0 168.0 169.0 187.0 176.0 171.0 171.0 170.0 11:39:02 INFO - PID 5889 | 11:39:02 INFO - PID 5889 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:67.00 stddev:2.45 (3.7%) stddev-sans-first:2.52 11:39:02 INFO - PID 5889 | Values: 68.0 71.0 64.0 63.0 66.0 66.0 65.0 64.0 68.0 68.0 11:39:02 INFO - PID 5889 | -------- Summary: end -------- 11:39:02 INFO - PID 5889 | 11:39:03 INFO - PID 5889 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:39:03 INFO - TEST-INFO | 5889: exit 0 11:39:03 INFO - TEST-OK | kraken | took 62003ms 11:39:03 INFO - SUITE-END | took 1170s 11:39:03 INFO - Completed test suite (00:19:30) 11:39:03 INFO - javascript benchmark 11:39:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8492.71189300968, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3106.5029595264764, 3135.655077941426, 3154.1956801015735, 3154.432202203604, 3157.179133425309, 6156.168917196177, 6206.472449841769, 6218.937810621893, 6257.249130104388, 6328.462080723139, 6158.938410615892, 6181.165542651741, 6213.968930155343, 6217.0, 6254.906176407358, 5712.600117991753, 5744.368119506851, 5755.712214389285, 5778.162166485857, 5834.6790926499025, 5783.913241301384, 5796.768129274824, 5803.042497987827, 5838.708064596774, 5849.678267695296, 141.73074677386586, 5629.437056294379, 5722.828315150552, 5809.041508151171, 5813.0, 5606.383297837235, 5613.66318020916, 5675.971620141873, 5738.282714660668, 5771.971140144273, 5663.773449062032, 5697.202391665171, 5727.284089488814, 5742.28221472316, 5767.019606666835, 6133.6319820810895, 6185.8144255672405, 6191.0, 6213.751449941997, 6232.532560057968, 6548.607083575001, 6573.441257493071, 6649.700763465656, 6713.395794378481, 6726.529142959995, 6554.049662798868, 6670.83322916931, 6691.397774200345, 6710.42961348286, 6760.256371799098, 6255.06174073888, 6281.560290779647, 6286.151369565096, 6290.150829637986, 6312.684365781738, 6882.8967565486555, 6895.620740859201, 6905.896411553831, 6990.09128813251, 6999.23008469068, 6567.0, 6577.934220657828, 6641.966790166115, 6656.167979002625, 6678.465722742169, 6530.249021362509, 6639.302873198341, 6641.236257830411, 6715.832104197434, 6717.261101278856, 6713.798586042427, 6716.899246511306, 6733.158355205599, 6744.393004629607, 6755.594664320157, 6626.304238055031, 6703.3296670332575, 6709.731610735614, 6768.932310676929, 6800.149981252343, 5193.68837869729, 5221.503957124067, 5234.18870075139, 5259.868503287372, 5283.682979021271, 4489.820407183676, 4527.162474942146, 4568.428946381702, 4595.264757638762, 4664.137134630037, 5713.085906255063, 5783.913241301384, 5788.9710551447815, 5799.246098007232, 5799.768009279666, 6675.766348177791, 6684.0, 6742.9662851685425, 6767.2894346093935, 6779.72881084751, 5625.46558076982, 5737.168110623936, 5759.568032397587, 5813.88372232553, 5827.3007239131575, 5826.563007774434, 5855.3851845556455, 5860.443257890493, 5861.5603829712945, 5862.530997520274, 6350.33321501245, 6432.2602900667025, 6481.0, 6497.0, 6578.407943285128, 6635.767748128889, 6708.463322934056, 6781.050652908597, 6796.456283497408, 6804.081449004519, 6318.715657795318, 6373.171487706569, 6388.96805515988, 6406.295307516262, 6541.08424820516, 6543.901841472287, 6549.31232220629, 6585.440237579859, 6598.934010659832, 6603.0, 6706.195256569048, 6786.457083433413, 6797.354251346114, 6811.250762416229, 6841.418479429304, 6446.774362897276, 6458.483321334188, 6463.7737679181, 6556.114924485324, 6558.442532384801, 6322.589031712924, 6412.422881940461, 6412.519061070531, 6414.005829096497, 6508.772192973223, 6197.101420294122, 6263.154474145932, 6268.498520118288, 6270.467010304175, 6298.433141017331, 6471.514636402195, 6474.773382931575, 6556.573822701509, 6560.671966401565, 6627.768028118992, 6185.84535386619, 6273.874522509615, 6295.18162638854, 6356.77751278703, 6368.172137622079], "value": 6045.517945380857, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [746.3320328306163, 747.7270796159402, 773.0800347586372, 777.2887807655992, 779.7660701789462, 39250.80374598126, 39848.40227396584, 39869.80065099674, 39888.80055599725, 39958.0, 36298.274034519294, 36608.0, 36608.26783464329, 36634.0, 36643.26713465729, 6923.342282483169, 7011.859762804741, 7016.508844380895, 7031.191412987495, 7035.648217589126, 6843.931560684379, 6965.547239429447, 7719.65261563231, 7834.80412989677, 7838.137804841492, 7825.843483130334, 7850.607469626524, 7863.174366691501, 7877.015373078365, 7878.094019187781, 7707.344875685573, 7717.768466945972, 7792.10390805059, 7803.453758236926, 7817.061952565672, 7672.769816905502, 7677.769666910001, 7725.884111738328, 7729.420293478011, 7737.419693522952, 35779.28441431183, 35871.4619280711, 36272.27455450903, 36355.27289454223, 36379.0, 3451.3442445935443, 3452.913677158091, 3453.5510383650217, 3453.8273086345835, 3465.8960231193105, 29345.70654293451, 29464.41071178586, 29491.262718431997, 29530.409391812045, 29554.408911821858, 4899.828506002273, 5060.342155519796, 5062.291279220912, 5063.77213025411, 5079.31429257053, 177325.0, 178582.0, 178771.0, 178862.0, 178939.0, 45001.09997800091, 45116.77441612771, 45159.774201128785, 45230.547694523295, 45277.32084018742, 46909.5309046912, 47273.054538909026, 47334.5266547337, 47353.28970065452, 47376.05247895023, 14939.626509337353, 15094.39622415091, 15226.0, 15237.771433428508, 15257.0, 12441.315727635067, 12455.626331210078, 12456.31490268044, 12461.0, 12487.625371238877, 13908.4436622536, 13961.092528985584, 13991.16053036821, 14021.579352619437, 14094.295285235698, 5642.915356269659, 5725.541956643458, 5733.713314334266, 5755.942440575541, 5831.620944638585, 984.242133557157, 989.1987490133015, 991.4200192887098, 1000.4347543637822, 1007.8034783217203, 21036.894815525826, 21305.467363316042, 21462.678059829115, 21598.35204943854, 21925.780742192692, 1076.1821016027875, 1092.5411327242577, 1097.8078836203633, 1102.8345748137845, 1103.3876198709793, 11366.204365694488, 11436.313821170756, 11480.712982175346, 11624.0, 11633.069354451623, 214095.0, 215033.0, 215192.0, 215362.0, 215500.0, 49730.751346243764, 51831.0, 54403.72798135984, 54514.0, 54542.45457545374, 1408.253625578445, 1417.8156839610785, 1423.0465588056027, 1430.7353139669194, 1431.735129001159, 25261.989520419713, 25380.873095634404, 25477.235682929542, 25670.743292566836, 25961.870190648926, 34826.82586587152, 34842.0, 34870.12824679302, 34892.82553587216, 34940.65059349374, 183712.0, 183726.0, 183858.0, 184127.0, 184918.0, 29868.954586590233, 30133.246668833453, 30537.0, 30543.694563054974, 30583.08250752481, 37597.45481243296, 37998.050048749, 38035.80982095183, 38148.23703525969, 38356.0, 29293.26766830761, 29575.85212073926, 29771.702282976894, 30151.396972060873, 30188.69811301859, 29235.269118272212, 29265.26836829011, 29395.265118371357, 29474.0, 29879.701202987693, 32510.34979300448, 32660.836695816368, 32674.0, 32779.180520486225, 32864.17839553935, 28780.856095719388, 28912.0, 28920.855395722887, 29087.56368654514, 29120.0, 21613.68313785037, 21796.91015449253, 21904.561908761418, 22000.33998980033, 22064.156485079977], "value": 16303.815047938253, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.9548836093111, 575.2636625119845, 576.3084298841392, 577.1659951370269, 585.4672248254088, 21073.789262107373, 21766.564668706615, 21813.345599632015, 21813.345599632015, 21873.453163670918, 22605.54788904221, 23539.646905296435, 23947.0, 24130.638040429407, 24202.394940126505, 6468.3855033771715, 6632.137822083147, 6639.136912201407, 6639.634820084893, 6639.900401493981, 6164.938350616481, 6554.475641948657, 6641.900371494407, 6642.833929151761, 6660.700268487905, 6347.650879201642, 6351.237851457809, 6352.587081839665, 6356.269029061671, 6358.650274234915, 6353.714082866282, 6360.236771587439, 6360.363963603649, 6363.427291543783, 6364.586301890386, 6318.620882747004, 6524.478041756648, 6533.509986750965, 6535.052417399498, 6535.346465353474, 28304.15087547377, 28672.13983580496, 28717.856410717814, 28722.0, 28811.855940720372, 2089.6447603907222, 2107.4520624637553, 2112.8415368847245, 2113.228671534894, 2118.629239883014, 19313.51716207106, 19509.609807803907, 19634.410967670992, 19921.0, 19980.200791968306, 2540.5300019496453, 2545.923622291334, 2583.4316450381075, 2620.89516419343, 2621.6329713840078, 120822.0, 126893.0, 133846.3307683465, 140911.29544352315, 141308.0, 19616.901915490616, 19646.607067858848, 20308.69536956947, 20447.38657840267, 21030.579388412145, 40924.590754092074, 40932.0, 40934.181316373506, 40973.385399219034, 41044.0, 10793.384216287475, 10984.560617575367, 11003.944980275208, 11043.83434248487, 11162.944185279184, 9091.727248182566, 9114.088591140966, 9170.082991700776, 9192.080791920755, 9236.261099112055, 10560.0, 10763.83854242187, 10833.729156770985, 11062.612808551663, 11223.438828058564, 3705.962940370616, 3878.728489005799, 4041.474608300961, 4135.421041054255, 4234.640055595309, 929.3773171974793, 948.4925564822787, 971.8396464583406, 975.2393133355994, 980.2403137568299, 18458.0, 18981.24075036983, 19046.42860714153, 19105.808941910404, 19211.135498902582, 1024.5235965276183, 1028.1209565821264, 1029.7940411917646, 1037.7457522906784, 1039.4646756920192, 10290.279680422449, 10306.690799275884, 10348.482575871176, 10649.574017039231, 10693.465326733633, 449737.0, 450383.0, 453346.0, 459679.0, 465810.0, 112130.43934780273, 116392.41803790927, 118441.0, 119320.40339798419, 119504.0, 1027.5838285494387, 1068.4016950507585, 1134.2117228526095, 1136.534021051365, 1182.6097387861985, 19474.44204463668, 19525.414237572895, 19672.409827704618, 19740.111694973475, 20062.49843753918, 53979.0, 54166.18750718821, 54171.458285416644, 55085.724571376886, 57182.14226786518, 68558.0, 68591.31408685849, 68789.65605171942, 68949.65525172342, 69109.3089069123, 19425.708614370513, 19628.803711962697, 19773.901130494254, 19814.108365123317, 19918.203271868962, 22029.889850550644, 22185.889070554545, 22202.66695999529, 22418.0, 22523.0, 17532.649347013245, 17722.11389430549, 17808.643827123644, 17827.465176044738, 17900.373486927896, 15915.283812228246, 16308.0, 16490.670186595962, 16580.419685310957, 16816.243269053168, 18043.729344060113, 18288.634227315644, 18375.540611484284, 18556.536086597942, 18631.068446577345, 19040.238390464227, 19088.33190838314, 19106.33127840519, 19136.564757642955, 19152.329668461538, 17502.0, 17733.46799596014, 17913.283468661106, 18009.099545022433, 18030.09849507493], "value": 12539.801734062205, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1331.9533816316427, 1373.5947895370864, 1389.3122904162442, 1393.3869097597062, 1396.3158052554245, 14776.556703298906, 15204.695906081872, 15430.0, 15442.459513917016, 15445.382184712626, 15611.21943902806, 15858.762118568202, 15877.36490540377, 15878.285477153528, 15887.602809929758, 2766.294594878308, 2809.7892658050628, 2811.4939310924024, 2818.8026838121236, 2821.4921314163444, 2661.175035738927, 2794.3014246438393, 2795.4828356753965, 2800.215939536933, 2801.649793775778, 2726.986365068172, 2729.140320798942, 2752.587111933216, 2753.559430491122, 2764.1431156341496, 2706.120510833987, 2718.184544636601, 2735.8358498490156, 2736.53478908585, 2737.8494182819936, 2567.9101231457, 2582.780463660591, 2586.9870650646812, 2588.521123592123, 2589.5338839008973, 14862.777058344134, 15077.246137693071, 15240.085594864233, 15249.542513724606, 15254.313555890012, 7694.9230507694765, 7975.521468711896, 7979.800504987422, 7982.281594656451, 8008.079070906862, 5189.351331083614, 5239.21411788231, 5492.539699989022, 5495.368032676253, 5539.362973258087, 1821.271491403436, 1859.9535011624682, 1875.6436277107307, 1914.425672298305, 1925.1336898395778, 26402.0, 26583.601245981325, 26591.0, 26719.19842404731, 26721.331966700793, 6645.6012639240835, 7136.857262854817, 7151.0, 7383.520071195355, 7444.702211911463, 17072.48782536526, 17244.0, 17306.048167350666, 17307.567310817078, 17333.22000509955, 7577.659005344773, 7750.961245193738, 7755.767326980087, 7769.961150194326, 7773.455858089993, 5905.616134951214, 7067.752628657972, 7207.89188162178, 7265.164506081763, 7276.63616819157, 4520.864374068783, 5010.198368261061, 5143.254228136974, 5145.434002259748, 5147.6911385317, 1327.4889167670324, 1378.7518246715488, 1396.4972609860442, 1396.804447377368, 1415.2994267837487, 906.6917248135666, 926.9165775080276, 930.7393929699695, 931.9813603727888, 936.9437833729997, 8272.793180170544, 8493.405461617751, 8599.484030958163, 8619.310455163572, 8676.47941123522, 939.8684184214216, 969.8351280282369, 989.4211886046743, 999.9900001000043, 1020.7754294055296, 5117.462666419972, 5164.3802743671, 5178.860650656849, 5354.116570765858, 5682.176084467729, 21321.0, 21861.890690546446, 22116.115355385926, 22167.667484987738, 22199.556008879732, 20550.38348849537, 21377.358679239336, 21685.89157054236, 21699.0, 21741.78258217429, 11099.667009989713, 11254.930781575737, 11302.15233857464, 11413.315201087962, 11463.312201267783, 8525.44584601999, 8557.657693692432, 8593.91406085956, 8614.009388920103, 8662.653493860174, 18015.459536213933, 18832.0, 18836.52908677294, 19069.14188861477, 19193.98463161348, 18310.90844545822, 19233.326833560757, 19245.03774811282, 19984.0, 20000.599987999867, 10935.28920620157, 11055.115590752559, 11069.335839849313, 11084.390358530036, 11102.389368584805, 11879.703007424883, 13921.095128816594, 13921.373538190603, 14130.293485325486, 14273.357698903781, 10171.542280597243, 10325.896741032493, 10371.688849334532, 10393.06462418386, 10399.740006499898, 11139.777204456028, 11148.944255278671, 11344.716382090513, 11397.601083962021, 11497.1377146716, 9183.678571249975, 9297.0, 9391.906080939376, 9429.764255893657, 9439.056094390506, 6701.149081631807, 6816.727330906907, 6909.619970901648, 6932.549384290005, 7011.649417529001, 7358.0, 7376.409887209118, 7418.961345411539, 7425.9628701856145, 7545.811354716176], "value": 6653.094231025621, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [472.56287933661355, 493.7975430073668, 506.98986020279597, 507.99417154035, 524.5619907377339, 6256.119247906976, 6295.426143464134, 6362.650054247015, 6454.806355809327, 6463.289038205794, 6264.530160237978, 6286.811395658137, 6311.589746666464, 6335.651539165344, 6342.556021078526, 5214.634975551713, 5225.320708307924, 5248.71132087735, 5250.9474905250845, 5262.2632831403635, 4877.804887804484, 4934.4325402578625, 5049.192129259319, 5203.271541984125, 5235.476452354753, 4953.628477864175, 4954.43024052235, 4969.304297398367, 4981.139616796975, 5008.348914641109, 4957.628177886655, 4967.40391153064, 4974.5624643924575, 5008.574271186935, 5018.222175562793, 4420.513743488214, 4424.0, 4451.666125040635, 4454.752669252614, 4475.753833539154, 6055.939440605582, 6109.480694141003, 6121.530832600189, 6145.201123853915, 6212.596181248205, 5663.66018038919, 5687.317521897398, 5712.800571779853, 5738.139279108125, 5764.625299355528, 6514.283428822826, 6537.836554086186, 6584.489624607111, 6601.3728695773825, 6654.201495820533, 4641.628669706415, 4878.804847806084, 4887.1147437786685, 4904.779284932187, 4934.185859333205, 6678.499112566528, 6724.260331363546, 6943.201531823804, 7020.964895175492, 7023.82440438988, 5392.815909556636, 5401.540869026098, 5414.972925135349, 5484.177373394023, 5504.504594586427, 5486.643368181056, 5529.0, 5544.611877168641, 5553.0, 5590.413006634326, 5929.258842644669, 6047.9739287339235, 6057.212562366953, 6079.939200607937, 6082.635041897501, 6718.0, 6784.525083244224, 6785.253622101565, 6800.557963732342, 6839.1451068616425, 1925.4801203674929, 1931.744366161978, 1951.6096780643645, 1954.5602239496, 1957.9902100489692, 1370.1436602123672, 1432.3339647064165, 1439.1293267572967, 1452.9200893950722, 1462.8829693624484, 5693.829185124453, 5706.743196556165, 5758.222639943638, 5794.362620111784, 5806.767729290866, 6704.167374384317, 6794.564348521163, 6823.215330236987, 6835.453163746888, 6845.8973115403305, 5675.31896172462, 5748.895596377993, 5790.594658373873, 5807.751333463326, 5813.970930145322, 3543.2382037861466, 3578.177019285527, 3596.6692323839825, 3628.0748409155494, 3662.2675464907124, 6512.590341573648, 6519.706613202417, 6567.8358041048405, 6570.408663220333, 6572.8356791080605, 6892.555460644314, 6946.270641582662, 6959.807660586899, 7012.9298707013295, 7053.259407762213, 6497.011374767565, 6504.284528701839, 6568.343165683394, 6606.6036037837885, 6614.603123812587, 6735.562188457735, 6821.93178068213, 6827.863442731018, 6878.484113691393, 6898.758543450955, 6716.966415167893, 6736.326367363225, 6773.0, 6804.4216241620015, 6814.182298124257, 6461.160049193575, 6579.374959378852, 6596.373344532261, 6612.90080648781, 6680.528204564148, 5481.12302031689, 5507.531859791962, 5514.393416724077, 5526.917096243479, 5531.585131115102, 6516.100335350723, 6606.900896486461, 6743.393094621508, 6844.863102738017, 6872.518923675495, 6512.544121911421, 6528.967355163384, 6538.248101468392, 6540.201444602772, 6619.702113404812, 6480.477087884249, 6548.148740663683, 6552.770653027312, 6602.0, 6616.702248398929, 6251.9687401562705, 6344.175257216532, 6385.265694445198, 6394.776182833579, 6453.709583068679, 6484.157059582224, 6534.575252608565, 6663.800085997428, 6693.631850248283, 6733.057371968026, 6371.426571608577, 6378.619331754177, 6384.361563843579, 6443.355664433519, 6498.220213574401], "value": 5173.3078373141425, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [893.3523195683134, 917.6008436330196, 927.0682963621559, 932.1889955738509, 942.5051847779916, 18780.154893029812, 19890.303839365624, 19904.60190796183, 19936.60126797463, 19955.900220498912, 17345.39291124811, 17706.734398984026, 17851.91074044628, 18258.817411825912, 18411.171497282656, 986.9259805514579, 988.4217732626422, 988.9357191782547, 989.8267803134459, 995.2635050062974, 956.8229877472655, 990.7770751580908, 992.5632721602508, 996.0, 999.5901680311074, 1056.4400867540178, 1056.6248981611532, 1056.75166335911, 1057.9682609521726, 1058.4866339825178, 1052.0321304399931, 1053.5417093564324, 1053.6628278950739, 1055.0873494427342, 1055.5777688924416, 774.8217909880702, 775.2054144501931, 775.3487070860505, 775.5656832174001, 776.1772521127623, 19691.704624430644, 19830.305939292055, 19935.900320498306, 19954.900225498925, 19974.0, 20747.481312967295, 20785.480362990897, 21413.250536231313, 21453.67819482709, 21483.570328593498, 17544.736828947574, 17610.295588176457, 17667.911660441616, 17695.0, 17714.557136071573, 3712.424574191005, 3733.533308336458, 3755.7183211259266, 3777.471154038437, 3780.8865734028022, 138517.0, 140815.0, 141564.29217853947, 142550.0, 144619.0, 16199.433019844484, 16242.10668413225, 16254.837451625568, 16518.091504967102, 16521.91739041297, 30009.549856752164, 30741.538876916864, 30805.45972701356, 30812.691873081432, 30825.0, 8546.145385461528, 8561.828763424697, 8665.913340866511, 8676.34927380449, 8742.56287185651, 4053.1488387438967, 4106.1992911382595, 4107.979460102681, 4122.91754164915, 4125.463689720377, 5338.492843179892, 5442.074847275972, 5443.673379597158, 5446.101393270066, 5447.101228297287, 943.2077055273465, 995.4723996281982, 996.3673067602125, 997.8104160209537, 998.9800203996025, 685.5680921019725, 701.1411021498624, 705.7529864547367, 709.6593635055202, 720.0135813934943, 11678.416079196006, 12179.512819487121, 12563.87436125627, 12690.80963785544, 12803.487860485477, 668.6823758714571, 682.7610336382227, 690.2407351912856, 690.5821977703517, 692.4529621598981, 5593.664380137205, 5703.54371650267, 5722.599418040781, 5750.0, 5903.881922361528, 114350.42824785823, 116433.0, 116602.41698791452, 119862.0, 122050.0, 100704.0, 101830.0, 103188.48405757923, 103229.48385258026, 104844.47577762062, 89862.55068724614, 93061.53469232746, 93470.0652993475, 94249.52875235579, 95204.52397737966, 10539.57841686324, 10741.570337186426, 10744.946275268574, 10790.244682872437, 10867.782644347228, 44772.55227447814, 44837.32744008777, 45040.648780536634, 45771.31343029791, 45803.0, 55415.72292138675, 56388.71805640945, 56489.0, 57104.0, 57333.71333143308, 14665.706685866437, 14868.0, 15061.472848450252, 15074.170920599472, 15090.0, 15693.843061569694, 15993.760093598372, 16050.839491605402, 16051.598710032342, 16056.518304450885, 13603.591892243248, 13664.0, 13695.931520342732, 13708.794368084287, 13839.446422143, 15975.201239937724, 15997.440089596808, 16157.4344897928, 16172.514824555283, 16212.35150593963, 15326.770098448755, 15642.374305027672, 15668.68662626764, 15775.29011194522, 15863.127527986071, 10889.782204356026, 11046.502907369348, 11079.83380249313, 11163.665090047312, 11332.830007549728, 10618.628348007782, 10694.839577406501, 10750.731231718957, 10841.07850832688, 10891.78216435651], "value": 8819.585607684445, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1433.4999999999995, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 105.0, 108.0, 106.0, 108.0, 99.0, 109.0, 107.0, 107.0, 109.0], "value": 106.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 114.0, 115.0, 121.0, 121.0, 151.0, 118.0, 117.0, 119.0, 116.0], "value": 120.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 163.0, 162.0, 164.0, 164.0, 172.0, 164.0, 164.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 74.0, 73.0, 75.0, 84.0, 76.0, 73.0, 74.0], "value": 74.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 78.0, 79.0, 78.0, 78.0, 78.0, 88.0, 86.0, 79.0], "value": 80.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 112.0, 114.0, 113.0, 113.0, 113.0, 113.0, 114.0, 115.0], "value": 113.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 148.0, 149.0, 148.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 94.0, 93.0, 94.0, 99.0, 97.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 52.0, 52.0, 54.0, 52.0, 52.0, 52.0, 59.0, 49.0], "value": 52.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 39.0, 38.0, 39.0, 38.0, 38.0, 38.0, 38.0, 38.0, 39.0], "value": 38.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 76.0, 75.0, 78.0, 78.0, 75.0, 77.0, 85.0], "value": 76.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 124.0, 120.0, 120.0, 120.0, 124.0, 123.0, 118.0, 124.0, 121.0], "value": 122.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 173.0, 185.0, 168.0, 169.0, 187.0, 176.0, 171.0, 171.0, 170.0], "value": 174.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 64.0, 63.0, 66.0, 66.0, 65.0, 64.0, 68.0, 68.0], "value": 66.3, "unit": "score"}]}]} 11:39:03 INFO - Return code: 0 11:39:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:39:03 INFO - # TBPL SUCCESS # 11:39:03 INFO - Running post-action listener: _package_coverage_data 11:39:03 INFO - Running post-action listener: _resource_record_post_action 11:39:03 INFO - [mozharness: 2017-09-11 18:39:03.984114Z] Finished run-tests step (success) 11:39:03 INFO - Running post-run listener: _resource_record_post_run 11:39:04 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 301424640; Read time: 12; Write time: 258592 11:39:04 INFO - TinderboxPrint: CPU usage
13.1% 11:39:04 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 11:39:04 INFO - TinderboxPrint: I/O write bytes / time
301,424,640 / 258,592 11:39:04 INFO - TinderboxPrint: CPU idle
8,229.9 (86.9%) 11:39:04 INFO - TinderboxPrint: CPU user
1,190.7 (12.6%) 11:39:04 INFO - TinderboxPrint: Swap in / out
0 / 0 11:39:04 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 16916480; Read time: 0; Write time: 13988 11:39:04 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:39:04 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 284491776; Read time: 0; Write time: 244604 11:39:04 INFO - Running post-run listener: _upload_blobber_files 11:39:04 INFO - Blob upload gear active. 11:39:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:39:04 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:39:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:39:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:39:05 INFO - (blobuploader) - INFO - Open directory for files ... 11:39:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:39:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:39:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:39:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:39:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:39:06 INFO - (blobuploader) - INFO - Done attempting. 11:39:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:39:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:39:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:39:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:39:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:39:13 INFO - (blobuploader) - INFO - Done attempting. 11:39:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:39:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:39:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:39:14 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:39:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:39:14 INFO - (blobuploader) - INFO - Done attempting. 11:39:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:39:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:39:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:39:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:39:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:39:14 INFO - (blobuploader) - INFO - Done attempting. 11:39:14 INFO - (blobuploader) - INFO - Iteration through files over. 11:39:14 INFO - Return code: 0 11:39:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:39:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:39:14 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ecab301ab5ac6279704af8229b35b9e062c1522531759027fd34b170f5a5b896ae406e97f5d2cca4eb9654f20c697e0fa6fb89505e14d81a6d0b73a93179f25b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/96e41d249b83f008d01f97cef08fd1f489ce16df2429b3d6eb934fcb7004ee512afe5a739a5e26899196f76ea8133007c1398bde32ee7dcc5ed8eb55c2448234", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6779820757e31ccc9aa301d731ca3aa543c35c3223e6ebb9e5f3a52fa5e37c0721672d85e2c952ca520af13a43350def093ce8ef0e5c8bd5804b5434d54a78e6", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/addc41fcd04cbd9f72506dd9adbd51ce9feaf609d7b076cbdfda2af41c704a07cce4b4fef06ebe71fca892237b67750a3dea7b7ceb70c58a0fc7683ffeee1ec0"} 11:39:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:39:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:39:14 INFO - Contents: 11:39:14 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ecab301ab5ac6279704af8229b35b9e062c1522531759027fd34b170f5a5b896ae406e97f5d2cca4eb9654f20c697e0fa6fb89505e14d81a6d0b73a93179f25b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/96e41d249b83f008d01f97cef08fd1f489ce16df2429b3d6eb934fcb7004ee512afe5a739a5e26899196f76ea8133007c1398bde32ee7dcc5ed8eb55c2448234", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6779820757e31ccc9aa301d731ca3aa543c35c3223e6ebb9e5f3a52fa5e37c0721672d85e2c952ca520af13a43350def093ce8ef0e5c8bd5804b5434d54a78e6", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/addc41fcd04cbd9f72506dd9adbd51ce9feaf609d7b076cbdfda2af41c704a07cce4b4fef06ebe71fca892237b67750a3dea7b7ceb70c58a0fc7683ffeee1ec0"} 11:39:14 INFO - Running post-run listener: copy_logs_to_upload_dir 11:39:14 INFO - Copying logs to upload dir... 11:39:14 INFO - mkdir: /builds/slave/test/build/upload/logs 11:39:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.013242 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-11 11:39:14.915539) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-11 11:39:14.918915) ========= 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=ea65d483da93c827905c2090000001f5-1505153888.527711-1463032272 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/ecab301ab5ac6279704af8229b35b9e062c1522531759027fd34b170f5a5b896ae406e97f5d2cca4eb9654f20c697e0fa6fb89505e14d81a6d0b73a93179f25b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/96e41d249b83f008d01f97cef08fd1f489ce16df2429b3d6eb934fcb7004ee512afe5a739a5e26899196f76ea8133007c1398bde32ee7dcc5ed8eb55c2448234", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6779820757e31ccc9aa301d731ca3aa543c35c3223e6ebb9e5f3a52fa5e37c0721672d85e2c952ca520af13a43350def093ce8ef0e5c8bd5804b5434d54a78e6", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/addc41fcd04cbd9f72506dd9adbd51ce9feaf609d7b076cbdfda2af41c704a07cce4b4fef06ebe71fca892237b67750a3dea7b7ceb70c58a0fc7683ffeee1ec0"} build_url:https://queue.taskcluster.net/v1/task/C8epV1-GTcmlPzW_iPUoRQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011535 build_url: 'https://queue.taskcluster.net/v1/task/C8epV1-GTcmlPzW_iPUoRQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ecab301ab5ac6279704af8229b35b9e062c1522531759027fd34b170f5a5b896ae406e97f5d2cca4eb9654f20c697e0fa6fb89505e14d81a6d0b73a93179f25b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/96e41d249b83f008d01f97cef08fd1f489ce16df2429b3d6eb934fcb7004ee512afe5a739a5e26899196f76ea8133007c1398bde32ee7dcc5ed8eb55c2448234", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6779820757e31ccc9aa301d731ca3aa543c35c3223e6ebb9e5f3a52fa5e37c0721672d85e2c952ca520af13a43350def093ce8ef0e5c8bd5804b5434d54a78e6", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/addc41fcd04cbd9f72506dd9adbd51ce9feaf609d7b076cbdfda2af41c704a07cce4b4fef06ebe71fca892237b67750a3dea7b7ceb70c58a0fc7683ffeee1ec0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-11 11:39:14.947601) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 11:39:14.947929) ========= 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=ea65d483da93c827905c2090000001f5-1505153888.527711-1463032272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004521 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 11:39:15.033650) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-11 11:39:15.034142) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-11 11:39:15.034575) ========= ========= Total master_lag: 0.19 =========