builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-064 starttime: 1505557530.69 results: success (0) revision: 27e7b4261e4b5a016e09adb5332a181e43ab520e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 03:25:30.692991) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 03:25:30.693353) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 03:25:30.693631) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 03:25:30.740797) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:25:30.741111) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1505556404.851400-389019985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-16 03:25:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 105M=0s 2017-09-16 03:25:30 (105 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.129571 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:25:30.886302) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:25:30.886593) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1505556404.851400-389019985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014447 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:25:30.936381) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 12 secs) (at 2017-09-16 03:25:30.936716) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 27e7b4261e4b5a016e09adb5332a181e43ab520e --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 27e7b4261e4b5a016e09adb5332a181e43ab520e --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=a12cd81e0ef515edd9e0d800000001bb-1505556404.851400-389019985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-16 03:25:30,996 truncating revision to first 12 chars 2017-09-16 03:25:30,997 Setting DEBUG logging. 2017-09-16 03:25:30,997 attempt 1/10 2017-09-16 03:25:30,997 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/27e7b4261e4b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-16 03:25:32,258 attempt 1/10 2017-09-16 03:25:32,801 current task status: no status available at this point. state: STARTED 2017-09-16 03:25:32,802 sleeping for 10.00s (attempt 1/10) 2017-09-16 03:25:42,812 attempt 2/10 2017-09-16 03:25:43,358 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-09-16 03:25:43,541 unpacking tar archive at: mozilla-central-27e7b4261e4b/testing/mozharness/ program finished with exit code 0 elapsedTime=12.862789 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 12 secs) (at 2017-09-16 03:25:43.814870) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 03:25:43.815170) ========= script_repo_revision: 27e7b4261e4b5a016e09adb5332a181e43ab520e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 03:25:43.815546) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 03:25:43.815820) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 03:25:43.831445) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-16 03:25:43.831840) ========= /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=a12cd81e0ef515edd9e0d800000001bb-1505556404.851400-389019985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:25:44 INFO - MultiFileLogger online at 20170916 03:25:44 in /builds/slave/test 03:25:44 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 03:25:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:25:44 INFO - {'append_to_log': False, 03:25:44 INFO - 'base_work_dir': '/builds/slave/test', 03:25:44 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:25:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:25:44 INFO - 'branch': 'Firefox-Non-PGO', 03:25:44 INFO - 'buildbot_json_path': 'buildprops.json', 03:25:44 INFO - 'code_coverage': False, 03:25:44 INFO - 'config_files': ('talos/linux_config.py',), 03:25:44 INFO - 'default_actions': ('clobber', 03:25:44 INFO - 'read-buildbot-config', 03:25:44 INFO - 'download-and-extract', 03:25:44 INFO - 'populate-webroot', 03:25:44 INFO - 'create-virtualenv', 03:25:44 INFO - 'install', 03:25:44 INFO - 'setup-mitmproxy', 03:25:44 INFO - 'run-tests'), 03:25:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:25:44 INFO - 'disable_ccov_upload': False, 03:25:44 INFO - 'disable_stylo': False, 03:25:44 INFO - 'download_minidump_stackwalk': True, 03:25:44 INFO - 'download_symbols': 'ondemand', 03:25:44 INFO - 'enable_stylo': False, 03:25:44 INFO - 'enable_webrender': False, 03:25:44 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:25:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:25:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:25:44 INFO - 'gecko_profile': False, 03:25:44 INFO - 'gecko_profile_interval': 0, 03:25:44 INFO - 'installer_path': 'installer.exe', 03:25:44 INFO - 'log_level': 'info', 03:25:44 INFO - 'log_name': 'talos', 03:25:44 INFO - 'log_to_console': True, 03:25:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:25:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:25:44 INFO - 'opt_config_files': (), 03:25:44 INFO - 'pip_index': False, 03:25:44 INFO - 'suite': 'dromaeojs-e10s', 03:25:44 INFO - 'system_bits': '32', 03:25:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:25:44 INFO - 'title': 'talos-linux64-ix-064', 03:25:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:25:44 INFO - 'use_talos_json': True, 03:25:44 INFO - 'verify': 'False', 03:25:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:25:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:25:44 INFO - 'work_dir': 'build'} 03:25:44 INFO - [mozharness: 2017-09-16 10:25:44.028172Z] Running clobber step. 03:25:44 INFO - Running pre-action listener: _resource_record_pre_action 03:25:44 INFO - Running main action method: clobber 03:25:44 INFO - rmtree: /builds/slave/test/build 03:25:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:25:45 INFO - Running post-action listener: _resource_record_post_action 03:25:45 INFO - [mozharness: 2017-09-16 10:25:45.018181Z] Finished clobber step (success) 03:25:45 INFO - [mozharness: 2017-09-16 10:25:45.018279Z] Running read-buildbot-config step. 03:25:45 INFO - Running pre-action listener: _resource_record_pre_action 03:25:45 INFO - Running main action method: read_buildbot_config 03:25:45 INFO - Using buildbot properties: 03:25:45 INFO - { 03:25:45 INFO - "project": "", 03:25:45 INFO - "product": "firefox", 03:25:45 INFO - "who": "archaeopteryx@coole-files.de", 03:25:45 INFO - "installer_path": "public/build/target.tar.bz2", 03:25:45 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:25:45 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:25:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 03:25:45 INFO - "stage_platform": "linux64", 03:25:45 INFO - "basedir": "/builds/slave/test", 03:25:45 INFO - "buildnumber": 1154, 03:25:45 INFO - "platform": "ubuntu64_hw", 03:25:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:25:45 INFO - "slavebuilddir": "test", 03:25:45 INFO - "taskId": "daO4QEcYRRaHUBtEnx5Zmw", 03:25:45 INFO - "branch": "mozilla-central", 03:25:45 INFO - "script_repo_revision": "production", 03:25:45 INFO - "revision": "27e7b4261e4b5a016e09adb5332a181e43ab520e", 03:25:45 INFO - "slavename": "talos-linux64-ix-064", 03:25:45 INFO - "repo_path": "mozilla-central" 03:25:45 INFO - } 03:25:45 INFO - Finding installer, test and symbols from parent task. 03:25:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/daO4QEcYRRaHUBtEnx5Zmw'}, attempt #1 03:25:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/daO4QEcYRRaHUBtEnx5Zmw'}, attempt #1 03:25:45 INFO - Task dependencies: QKXeurjvQniffQGOJwEu5g 03:25:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QKXeurjvQniffQGOJwEu5g'}, attempt #1 03:25:46 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/QKXeurjvQniffQGOJwEu5g/artifacts/public/build/target.tar.bz2 03:25:46 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/QKXeurjvQniffQGOJwEu5g/artifacts/public/build/target.test_packages.json 03:25:46 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/QKXeurjvQniffQGOJwEu5g/artifacts/public/build/target.crashreporter-symbols.zip 03:25:46 INFO - Running post-action listener: _resource_record_post_action 03:25:46 INFO - [mozharness: 2017-09-16 10:25:46.378206Z] Finished read-buildbot-config step (success) 03:25:46 INFO - [mozharness: 2017-09-16 10:25:46.378424Z] Running download-and-extract step. 03:25:46 INFO - Running pre-action listener: _resource_record_pre_action 03:25:46 INFO - Running main action method: download_and_extract 03:25:46 INFO - mkdir: /builds/slave/test/build/tests 03:25:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:46 INFO - trying https://queue.taskcluster.net/v1/task/QKXeurjvQniffQGOJwEu5g/artifacts/public/build/target.test_packages.json 03:25:46 INFO - Downloading https://queue.taskcluster.net/v1/task/QKXeurjvQniffQGOJwEu5g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:25:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QKXeurjvQniffQGOJwEu5g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:25:46 INFO - Downloaded 989 bytes. 03:25:46 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:25:46 INFO - Using the following test package requirements: 03:25:46 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:25:46 INFO - u'common': [u'target.common.tests.zip'], 03:25:46 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:25:46 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:25:46 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:25:46 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:25:46 INFO - u'mozbase': [u'target.common.tests.zip'], 03:25:46 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:25:46 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:25:46 INFO - u'web-platform': [u'target.common.tests.zip', 03:25:46 INFO - u'target.web-platform.tests.tar.gz'], 03:25:46 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:25:46 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:25:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QKXeurjvQniffQGOJwEu5g/artifacts/public/build/target.common.tests.zip 03:25:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QKXeurjvQniffQGOJwEu5g/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:25:46 INFO - Fetch https://queue.taskcluster.net/v1/task/QKXeurjvQniffQGOJwEu5g/artifacts/public/build/target.common.tests.zip into memory 03:25:48 INFO - Content-Length response header: 54731147 03:25:48 INFO - Bytes received: 54731147 03:25:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QKXeurjvQniffQGOJwEu5g/artifacts/public/build/target.talos.tests.zip 03:25:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QKXeurjvQniffQGOJwEu5g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:25:59 INFO - Fetch https://queue.taskcluster.net/v1/task/QKXeurjvQniffQGOJwEu5g/artifacts/public/build/target.talos.tests.zip into memory 03:26:00 INFO - Content-Length response header: 14508748 03:26:00 INFO - Bytes received: 14508748 03:26: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')]} 03:26:01 INFO - trying https://queue.taskcluster.net/v1/task/QKXeurjvQniffQGOJwEu5g/artifacts/public/build/target.tar.bz2 03:26:01 INFO - Downloading https://queue.taskcluster.net/v1/task/QKXeurjvQniffQGOJwEu5g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:26:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QKXeurjvQniffQGOJwEu5g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:26:02 INFO - Downloaded 61630448 bytes. 03:26:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QKXeurjvQniffQGOJwEu5g/artifacts/public/build/target.tar.bz2 03:26:02 INFO - mkdir: /builds/slave/test/properties 03:26:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:26:02 INFO - Writing to file /builds/slave/test/properties/build_url 03:26:02 INFO - Contents: 03:26:02 INFO - build_url:https://queue.taskcluster.net/v1/task/QKXeurjvQniffQGOJwEu5g/artifacts/public/build/target.tar.bz2 03:26:02 INFO - Running post-action listener: _resource_record_post_action 03:26:02 INFO - Running post-action listener: find_tests_for_verification 03:26:02 INFO - Running post-action listener: set_extra_try_arguments 03:26:02 INFO - [mozharness: 2017-09-16 10:26:02.670708Z] Finished download-and-extract step (success) 03:26:02 INFO - [mozharness: 2017-09-16 10:26:02.670937Z] Running populate-webroot step. 03:26:02 INFO - Running pre-action listener: _resource_record_pre_action 03:26:02 INFO - Running main action method: populate_webroot 03:26:02 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:26:02 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:26:02 INFO - 'tests': ['tresize', 03:26:02 INFO - 'tcanvasmark']}, 03:26:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:26:02 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:26:02 INFO - 'tests': ['dromaeo_css', 03:26:02 INFO - 'kraken']}, 03:26:02 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:26:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:26:02 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:26:02 INFO - 'talos_options': ['--disable-stylo'], 03:26:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:26:02 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:26:02 INFO - 'tests': ['damp', 'tps']}, 03:26:02 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:26:02 INFO - 'talos_options': ['--disable-stylo'], 03:26:02 INFO - 'tests': ['damp', 'tps']}, 03:26:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:26:02 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:26:02 INFO - 'tests': ['dromaeo_dom']}, 03:26:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:26:02 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:26:02 INFO - 'tests': ['basic_compositor_video', 03:26:02 INFO - 'glvideo']}, 03:26:02 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:26:02 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:26:02 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:26:02 INFO - 'talos_options': ['--disable-stylo'], 03:26:02 INFO - 'tests': ['ts_paint_webext', 03:26:02 INFO - 'tp5o_webext']}, 03:26:02 INFO - 'other-e10s': {'tests': ['a11yr', 03:26:02 INFO - 'ts_paint', 03:26:02 INFO - 'tpaint', 03:26:02 INFO - 'sessionrestore', 03:26:02 INFO - 'sessionrestore_many_windows', 03:26:02 INFO - 'sessionrestore_no_auto_restore', 03:26:02 INFO - 'tabpaint']}, 03:26:02 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:26:02 INFO - 'tests': ['a11yr', 03:26:02 INFO - 'ts_paint', 03:26:02 INFO - 'tpaint', 03:26:02 INFO - 'sessionrestore', 03:26:02 INFO - 'sessionrestore_many_windows', 03:26:02 INFO - 'sessionrestore_no_auto_restore', 03:26:02 INFO - 'tabpaint']}, 03:26:02 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:26:02 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 03:26:02 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:26:02 INFO - 'tests': ['perf_reftest_singletons']}, 03:26:02 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:26:02 INFO - 'tests': ['bloom_basic']}, 03:26:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:26:02 INFO - 'tsvgr_opacity', 03:26:02 INFO - 'tart', 03:26:02 INFO - 'tscrollx', 03:26:02 INFO - 'tsvg_static']}, 03:26:02 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:26:02 INFO - 'tests': ['tsvgx', 03:26:02 INFO - 'tsvgr_opacity', 03:26:02 INFO - 'tart', 03:26:02 INFO - 'tscrollx', 03:26:02 INFO - 'tsvg_static']}, 03:26:02 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:26:02 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:26:02 INFO - 'talos_options': ['--disable-stylo'], 03:26:02 INFO - 'tests': ['tp5o']}, 03:26:02 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:26:02 INFO - 'talos_options': ['--mitmproxy', 03:26:02 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:26:02 INFO - '--firstNonBlankPaint'], 03:26:02 INFO - 'tests': ['tp6_google', 03:26:02 INFO - 'tp6_youtube', 03:26:02 INFO - 'tp6_amazon', 03:26:02 INFO - 'tp6_facebook']}, 03:26:02 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:26:02 INFO - 'talos_options': ['--disable-stylo', 03:26:02 INFO - '--mitmproxy', 03:26:02 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:26:02 INFO - '--firstNonBlankPaint'], 03:26:02 INFO - 'tests': ['tp6_google', 03:26:02 INFO - 'tp6_youtube', 03:26:02 INFO - 'tp6_amazon', 03:26:02 INFO - 'tp6_facebook']}, 03:26:02 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:26:02 INFO - 'talos_options': ['--stylo-threads=1', 03:26:02 INFO - '--mitmproxy', 03:26:02 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:26:02 INFO - '--firstNonBlankPaint'], 03:26:02 INFO - 'tests': ['tp6_google', 03:26:02 INFO - 'tp6_youtube', 03:26:02 INFO - 'tp6_amazon', 03:26:02 INFO - 'tp6_facebook']}, 03:26:02 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:26:02 INFO - 'talos_options': ['--xperf_path', 03:26:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:26:02 INFO - 'tests': ['tp5n']}, 03:26:02 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:26:02 INFO - 'talos_options': ['--disable-stylo', 03:26:02 INFO - '--xperf_path', 03:26:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:26:02 INFO - 'tests': ['tp5n']}}} 03:26:02 INFO - Running post-action listener: _resource_record_post_action 03:26:02 INFO - [mozharness: 2017-09-16 10:26:02.686168Z] Finished populate-webroot step (success) 03:26:02 INFO - [mozharness: 2017-09-16 10:26:02.686258Z] Running create-virtualenv step. 03:26:02 INFO - Running pre-action listener: _resource_record_pre_action 03:26:02 INFO - Running main action method: create_virtualenv 03:26:02 INFO - Creating virtualenv /builds/slave/test/build/venv 03:26:02 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:26:02 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:26:02 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:26:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:26:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:26:03 INFO - Installing distribute.............................................................................................................................................................................................done. 03:26:03 INFO - Installing pip...............done. 03:26:03 INFO - Return code: 0 03:26:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:26:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:26:03 INFO - Reading from file tmpfile_stdout 03:26:03 INFO - Output received: 03:26:03 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:26:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:26:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2874a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2878090>, '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 0x2878d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2872f90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1505556404.851400-389019985', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:26: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', 'pip>=1.5'] in /builds/slave/test/build 03:26: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 pip>=1.5 03:26:03 INFO - Using env: {'DISPLAY': ':0', 03:26:03 INFO - 'HOME': '/home/cltbld', 03:26:03 INFO - 'LANG': 'en_US.UTF-8', 03:26:03 INFO - 'LANGUAGE': 'en_US:en', 03:26:03 INFO - 'LOGNAME': 'cltbld', 03:26:03 INFO - 'MAIL': '/var/mail/cltbld', 03:26:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:03 INFO - 'MOZ_NO_REMOTE': '1', 03:26:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:03 INFO - 'NO_EM_RESTART': '1', 03:26:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:03 INFO - 'PWD': '/builds/slave/test', 03:26:03 INFO - 'SHELL': '/bin/bash', 03:26:03 INFO - 'SHLVL': '1', 03:26:03 INFO - 'TERM': 'linux', 03:26:03 INFO - 'TMOUT': '86400', 03:26:03 INFO - 'USER': 'cltbld', 03:26:03 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1505556404.851400-389019985', 03:26:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:03 INFO - '_': '/tools/buildbot/bin/python'} 03:26:04 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:26:04 INFO - Downloading/unpacking pip>=1.5 03:26:04 INFO - Running setup.py egg_info for package pip 03:26:04 INFO - warning: no files found matching 'pip/cacert.pem' 03:26:04 INFO - warning: no files found matching '*.html' under directory 'docs' 03:26:04 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:26:04 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:26:04 INFO - Installing collected packages: pip 03:26:04 INFO - Found existing installation: pip 1.1 03:26:04 INFO - Uninstalling pip: 03:26:04 INFO - Successfully uninstalled pip 03:26:04 INFO - Running setup.py install for pip 03:26:04 INFO - warning: no files found matching 'pip/cacert.pem' 03:26:04 INFO - warning: no files found matching '*.html' under directory 'docs' 03:26:04 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:26:04 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:26:04 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:26:04 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:26:04 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:26:04 INFO - Successfully installed pip 03:26:04 INFO - Cleaning up... 03:26:04 INFO - Return code: 0 03:26:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:26: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')]} 03:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26: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')]} 03:26:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26: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', '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 0x25081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2874a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2878090>, '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 0x2878d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2872f90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1505556404.851400-389019985', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:26: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', 'psutil>=3.1.1'] in /builds/slave/test/build 03:26: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 psutil>=3.1.1 03:26:04 INFO - Using env: {'DISPLAY': ':0', 03:26:04 INFO - 'HOME': '/home/cltbld', 03:26:04 INFO - 'LANG': 'en_US.UTF-8', 03:26:04 INFO - 'LANGUAGE': 'en_US:en', 03:26:04 INFO - 'LOGNAME': 'cltbld', 03:26:04 INFO - 'MAIL': '/var/mail/cltbld', 03:26:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:04 INFO - 'MOZ_NO_REMOTE': '1', 03:26:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:04 INFO - 'NO_EM_RESTART': '1', 03:26:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:04 INFO - 'PWD': '/builds/slave/test', 03:26:04 INFO - 'SHELL': '/bin/bash', 03:26:04 INFO - 'SHLVL': '1', 03:26:04 INFO - 'TERM': 'linux', 03:26:04 INFO - 'TMOUT': '86400', 03:26:04 INFO - 'USER': 'cltbld', 03:26:04 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1505556404.851400-389019985', 03:26:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:04 INFO - '_': '/tools/buildbot/bin/python'} 03:26:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:05 INFO - Downloading/unpacking psutil>=3.1.1 03:26: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 03:26: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 03:26: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 03:26: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 03:26:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:26:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:26:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:26:06 INFO - Installing collected packages: psutil 03:26:06 INFO - Running setup.py install for psutil 03:26:06 INFO - building 'psutil._psutil_linux' extension 03:26:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:26:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:26:06 INFO - building 'psutil._psutil_posix' extension 03:26:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:26:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:26:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:26:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:26:07 INFO - Successfully installed psutil 03:26:07 INFO - Cleaning up... 03:26:07 INFO - Return code: 0 03:26:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:26:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2874a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2878090>, '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 0x2878d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2872f90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1505556404.851400-389019985', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:26:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:26:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:26:07 INFO - Using env: {'DISPLAY': ':0', 03:26:07 INFO - 'HOME': '/home/cltbld', 03:26:07 INFO - 'LANG': 'en_US.UTF-8', 03:26:07 INFO - 'LANGUAGE': 'en_US:en', 03:26:07 INFO - 'LOGNAME': 'cltbld', 03:26:07 INFO - 'MAIL': '/var/mail/cltbld', 03:26:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:07 INFO - 'MOZ_NO_REMOTE': '1', 03:26:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:07 INFO - 'NO_EM_RESTART': '1', 03:26:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:07 INFO - 'PWD': '/builds/slave/test', 03:26:07 INFO - 'SHELL': '/bin/bash', 03:26:07 INFO - 'SHLVL': '1', 03:26:07 INFO - 'TERM': 'linux', 03:26:07 INFO - 'TMOUT': '86400', 03:26:07 INFO - 'USER': 'cltbld', 03:26:07 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1505556404.851400-389019985', 03:26:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:07 INFO - '_': '/tools/buildbot/bin/python'} 03:26:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:26:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:26:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:26:09 INFO - Installing collected packages: mozsystemmonitor 03:26:09 INFO - Running setup.py install for mozsystemmonitor 03:26:09 INFO - Successfully installed mozsystemmonitor 03:26:09 INFO - Cleaning up... 03:26:09 INFO - Return code: 0 03:26:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:26:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2874a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2878090>, '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 0x2878d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2872f90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1505556404.851400-389019985', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:26:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:26:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:26:09 INFO - Using env: {'DISPLAY': ':0', 03:26:09 INFO - 'HOME': '/home/cltbld', 03:26:09 INFO - 'LANG': 'en_US.UTF-8', 03:26:09 INFO - 'LANGUAGE': 'en_US:en', 03:26:09 INFO - 'LOGNAME': 'cltbld', 03:26:09 INFO - 'MAIL': '/var/mail/cltbld', 03:26:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:09 INFO - 'MOZ_NO_REMOTE': '1', 03:26:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:09 INFO - 'NO_EM_RESTART': '1', 03:26:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:09 INFO - 'PWD': '/builds/slave/test', 03:26:09 INFO - 'SHELL': '/bin/bash', 03:26:09 INFO - 'SHLVL': '1', 03:26:09 INFO - 'TERM': 'linux', 03:26:09 INFO - 'TMOUT': '86400', 03:26:09 INFO - 'USER': 'cltbld', 03:26:09 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1505556404.851400-389019985', 03:26:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:09 INFO - '_': '/tools/buildbot/bin/python'} 03:26:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:09 INFO - Downloading/unpacking jsonschema==2.5.1 03:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:26:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:26: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 03:26: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 03:26: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 03:26: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 03:26:11 INFO - Downloading functools32-3.2.3-2.tar.gz 03:26:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:26:11 INFO - warning: no files found matching '*.txt' 03:26:11 INFO - no previously-included directories found matching 'build' 03:26:11 INFO - no previously-included directories found matching 'dist' 03:26:11 INFO - no previously-included directories found matching '.git*' 03:26:11 INFO - Installing collected packages: jsonschema, functools32 03:26:11 INFO - Running setup.py install for functools32 03:26:11 INFO - warning: no files found matching '*.txt' 03:26:11 INFO - no previously-included directories found matching 'build' 03:26:11 INFO - no previously-included directories found matching 'dist' 03:26:11 INFO - no previously-included directories found matching '.git*' 03:26:11 INFO - Successfully installed jsonschema functools32 03:26:11 INFO - Cleaning up... 03:26:11 INFO - Return code: 0 03:26:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:26:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:11 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 0x25081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2874a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2878090>, '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 0x2878d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2872f90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1505556404.851400-389019985', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:26:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:26:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:26:11 INFO - Using env: {'DISPLAY': ':0', 03:26:11 INFO - 'HOME': '/home/cltbld', 03:26:11 INFO - 'LANG': 'en_US.UTF-8', 03:26:11 INFO - 'LANGUAGE': 'en_US:en', 03:26:11 INFO - 'LOGNAME': 'cltbld', 03:26:11 INFO - 'MAIL': '/var/mail/cltbld', 03:26:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:11 INFO - 'MOZ_NO_REMOTE': '1', 03:26:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:11 INFO - 'NO_EM_RESTART': '1', 03:26:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:11 INFO - 'PWD': '/builds/slave/test', 03:26:11 INFO - 'SHELL': '/bin/bash', 03:26:11 INFO - 'SHLVL': '1', 03:26:11 INFO - 'TERM': 'linux', 03:26:11 INFO - 'TMOUT': '86400', 03:26:11 INFO - 'USER': 'cltbld', 03:26:11 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1505556404.851400-389019985', 03:26:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:11 INFO - '_': '/tools/buildbot/bin/python'} 03:26:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:26:11 INFO - Cleaning up... 03:26:11 INFO - Return code: 0 03:26:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:26:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:11 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 0x25081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2874a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2878090>, '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 0x2878d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2872f90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1505556404.851400-389019985', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:26:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:26:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:26:11 INFO - Using env: {'DISPLAY': ':0', 03:26:11 INFO - 'HOME': '/home/cltbld', 03:26:11 INFO - 'LANG': 'en_US.UTF-8', 03:26:11 INFO - 'LANGUAGE': 'en_US:en', 03:26:11 INFO - 'LOGNAME': 'cltbld', 03:26:11 INFO - 'MAIL': '/var/mail/cltbld', 03:26:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:11 INFO - 'MOZ_NO_REMOTE': '1', 03:26:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:11 INFO - 'NO_EM_RESTART': '1', 03:26:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:11 INFO - 'PWD': '/builds/slave/test', 03:26:11 INFO - 'SHELL': '/bin/bash', 03:26:11 INFO - 'SHLVL': '1', 03:26:11 INFO - 'TERM': 'linux', 03:26:11 INFO - 'TMOUT': '86400', 03:26:11 INFO - 'USER': 'cltbld', 03:26:11 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1505556404.851400-389019985', 03:26:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:11 INFO - '_': '/tools/buildbot/bin/python'} 03:26:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:11 INFO - Downloading/unpacking blobuploader==1.2.4 03:26: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 03:26: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 03:26: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 03:26: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 03:26:12 INFO - Downloading blobuploader-1.2.4.tar.gz 03:26:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:26:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:26: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 03:26: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 03:26: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 03:26: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 03:26:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:26:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:26: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 03:26: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 03:26: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 03:26: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 03:26:13 INFO - Downloading docopt-0.6.1.tar.gz 03:26:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:26:13 INFO - Installing collected packages: blobuploader, requests, docopt 03:26:13 INFO - Running setup.py install for blobuploader 03:26:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:26:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:26:13 INFO - Running setup.py install for requests 03:26:14 INFO - Running setup.py install for docopt 03:26:14 INFO - Successfully installed blobuploader requests docopt 03:26:14 INFO - Cleaning up... 03:26:14 INFO - Return code: 0 03:26:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:14 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 0x25081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2874a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2878090>, '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 0x2878d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2872f90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1505556404.851400-389019985', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:26:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:26:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:26:14 INFO - Using env: {'DISPLAY': ':0', 03:26:14 INFO - 'HOME': '/home/cltbld', 03:26:14 INFO - 'LANG': 'en_US.UTF-8', 03:26:14 INFO - 'LANGUAGE': 'en_US:en', 03:26:14 INFO - 'LOGNAME': 'cltbld', 03:26:14 INFO - 'MAIL': '/var/mail/cltbld', 03:26:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:14 INFO - 'MOZ_NO_REMOTE': '1', 03:26:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:14 INFO - 'NO_EM_RESTART': '1', 03:26:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:14 INFO - 'PWD': '/builds/slave/test', 03:26:14 INFO - 'SHELL': '/bin/bash', 03:26:14 INFO - 'SHLVL': '1', 03:26:14 INFO - 'TERM': 'linux', 03:26:14 INFO - 'TMOUT': '86400', 03:26:14 INFO - 'USER': 'cltbld', 03:26:14 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1505556404.851400-389019985', 03:26:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:14 INFO - '_': '/tools/buildbot/bin/python'} 03:26:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:26:14 INFO - Running setup.py (path:/tmp/pip-CJ9xH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:26:14 INFO - Running setup.py (path:/tmp/pip-HCk7K7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:26:14 INFO - Running setup.py (path:/tmp/pip-tX36QZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:26:14 INFO - Running setup.py (path:/tmp/pip-uVxaX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:26:14 INFO - Running setup.py (path:/tmp/pip-IA9_Gp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:26:14 INFO - Running setup.py (path:/tmp/pip-9bEyYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:26:14 INFO - Running setup.py (path:/tmp/pip-uiutby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:26:14 INFO - Running setup.py (path:/tmp/pip-XnsEoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:26:14 INFO - Running setup.py (path:/tmp/pip-H6AQXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:26:14 INFO - Running setup.py (path:/tmp/pip-iQLsCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:26:15 INFO - Running setup.py (path:/tmp/pip-sOLQ20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:26:15 INFO - Running setup.py (path:/tmp/pip-zDhXwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:26:15 INFO - Running setup.py (path:/tmp/pip-jvqb9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:26:15 INFO - Running setup.py (path:/tmp/pip-gZp3LU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:15 INFO - Running setup.py (path:/tmp/pip-tYDH7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:26:15 INFO - Running setup.py (path:/tmp/pip-sxUZ1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:26:15 INFO - Running setup.py (path:/tmp/pip-zDYspc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:26:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:26:15 INFO - Running setup.py install for manifestparser 03:26:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:26:15 INFO - Running setup.py install for mozcrash 03:26:15 INFO - Running setup.py install for mozdebug 03:26:15 INFO - Running setup.py install for mozdevice 03:26:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:26:15 INFO - Running setup.py install for mozfile 03:26:16 INFO - Running setup.py install for mozhttpd 03:26:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:26:16 INFO - Running setup.py install for mozinfo 03:26:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:26:16 INFO - Running setup.py install for mozInstall 03:26:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:26:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:26:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:26:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:26:16 INFO - Running setup.py install for mozleak 03:26:16 INFO - Running setup.py install for mozlog 03:26:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:26:16 INFO - Running setup.py install for moznetwork 03:26:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:26:16 INFO - Running setup.py install for mozprocess 03:26:16 INFO - Running setup.py install for mozprofile 03:26:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:26:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:26:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:26:16 INFO - Running setup.py install for mozrunner 03:26:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:26:16 INFO - Running setup.py install for mozscreenshot 03:26:17 INFO - Running setup.py install for moztest 03:26:17 INFO - Running setup.py install for mozversion 03:26:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:26:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:26:17 INFO - Cleaning up... 03:26:17 INFO - Return code: 0 03:26:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:17 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 0x25081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2874a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2878090>, '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 0x2878d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2872f90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1505556404.851400-389019985', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:26:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:26:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:26:17 INFO - Using env: {'DISPLAY': ':0', 03:26:17 INFO - 'HOME': '/home/cltbld', 03:26:17 INFO - 'LANG': 'en_US.UTF-8', 03:26:17 INFO - 'LANGUAGE': 'en_US:en', 03:26:17 INFO - 'LOGNAME': 'cltbld', 03:26:17 INFO - 'MAIL': '/var/mail/cltbld', 03:26:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:17 INFO - 'MOZ_NO_REMOTE': '1', 03:26:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:17 INFO - 'NO_EM_RESTART': '1', 03:26:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:17 INFO - 'PWD': '/builds/slave/test', 03:26:17 INFO - 'SHELL': '/bin/bash', 03:26:17 INFO - 'SHLVL': '1', 03:26:17 INFO - 'TERM': 'linux', 03:26:17 INFO - 'TMOUT': '86400', 03:26:17 INFO - 'USER': 'cltbld', 03:26:17 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1505556404.851400-389019985', 03:26:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:17 INFO - '_': '/tools/buildbot/bin/python'} 03:26:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:26:17 INFO - Running setup.py (path:/tmp/pip-jQzKo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:26:17 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:26:17 INFO - Running setup.py (path:/tmp/pip-LLpSTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:26:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:26:17 INFO - Running setup.py (path:/tmp/pip-23iMxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:26:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:26:17 INFO - Running setup.py (path:/tmp/pip-h7nC6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:26:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:26:17 INFO - Running setup.py (path:/tmp/pip-HtNaPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:26:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:26:17 INFO - Running setup.py (path:/tmp/pip-YsF2Ca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:26:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:26:17 INFO - Running setup.py (path:/tmp/pip-q1a48v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:26:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:26:18 INFO - Running setup.py (path:/tmp/pip-WB5j4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:26:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:26:18 INFO - Running setup.py (path:/tmp/pip-xnJxEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:26:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:26:18 INFO - Running setup.py (path:/tmp/pip-OiBirl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:26:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:26:18 INFO - Running setup.py (path:/tmp/pip-8TgBsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:26:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:26:18 INFO - Running setup.py (path:/tmp/pip-DfdVeg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:26:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:26:18 INFO - Running setup.py (path:/tmp/pip-qqG256-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:26:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:26:18 INFO - Running setup.py (path:/tmp/pip-PNpMhy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:26:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:18 INFO - Running setup.py (path:/tmp/pip-cPrknp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:26:18 INFO - Running setup.py (path:/tmp/pip-2IG_KR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:26:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:26:18 INFO - Running setup.py (path:/tmp/pip-7WK_1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:26:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:26:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:26:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:26:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:26:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:26:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:26:18 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:26:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:26:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:19 INFO - Downloading blessings-1.6.tar.gz 03:26:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:26:19 INFO - Installing collected packages: blessings 03:26:19 INFO - Running setup.py install for blessings 03:26:20 INFO - Successfully installed blessings 03:26:20 INFO - Cleaning up... 03:26:20 INFO - Return code: 0 03:26:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:26:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:26:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:26:20 INFO - Reading from file tmpfile_stdout 03:26:20 INFO - Current package versions: 03:26:20 INFO - argparse == 1.2.1 03:26:20 INFO - blessings == 1.6 03:26:20 INFO - blobuploader == 1.2.4 03:26:20 INFO - docopt == 0.6.1 03:26:20 INFO - functools32 == 3.2.3-2 03:26:20 INFO - jsonschema == 2.5.1 03:26:20 INFO - manifestparser == 1.1 03:26:20 INFO - mozInstall == 1.13 03:26:20 INFO - mozcrash == 1.0 03:26:20 INFO - mozdebug == 0.1 03:26:20 INFO - mozdevice == 0.51 03:26:20 INFO - mozfile == 1.2 03:26:20 INFO - mozhttpd == 0.7 03:26:20 INFO - mozinfo == 0.10 03:26:20 INFO - mozleak == 0.1 03:26:20 INFO - mozlog == 3.5 03:26:20 INFO - moznetwork == 0.27 03:26:20 INFO - mozprocess == 0.25 03:26:20 INFO - mozprofile == 0.28 03:26:20 INFO - mozrunner == 6.13 03:26:20 INFO - mozscreenshot == 0.1 03:26:20 INFO - mozsystemmonitor == 0.3 03:26:20 INFO - moztest == 0.8 03:26:20 INFO - mozversion == 1.4 03:26:20 INFO - psutil == 3.1.1 03:26:20 INFO - requests == 1.2.3 03:26:20 INFO - wsgiref == 0.1.2 03:26:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:20 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 0x25081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2874a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2878090>, '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 0x2878d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2872f90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1505556404.851400-389019985', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:26:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:26:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:26:20 INFO - Using env: {'DISPLAY': ':0', 03:26:20 INFO - 'HOME': '/home/cltbld', 03:26:20 INFO - 'LANG': 'en_US.UTF-8', 03:26:20 INFO - 'LANGUAGE': 'en_US:en', 03:26:20 INFO - 'LOGNAME': 'cltbld', 03:26:20 INFO - 'MAIL': '/var/mail/cltbld', 03:26:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:20 INFO - 'MOZ_NO_REMOTE': '1', 03:26:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:20 INFO - 'NO_EM_RESTART': '1', 03:26:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:20 INFO - 'PWD': '/builds/slave/test', 03:26:20 INFO - 'SHELL': '/bin/bash', 03:26:20 INFO - 'SHLVL': '1', 03:26:20 INFO - 'TERM': 'linux', 03:26:20 INFO - 'TMOUT': '86400', 03:26:20 INFO - 'USER': 'cltbld', 03:26:20 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1505556404.851400-389019985', 03:26:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:20 INFO - '_': '/tools/buildbot/bin/python'} 03:26:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:26:20 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:26:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:26:21 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:26:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:26:21 INFO - Installing collected packages: simplejson 03:26:21 INFO - Running setup.py install for simplejson 03:26:21 INFO - building 'simplejson._speedups' extension 03:26:21 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 03:26:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:26:22 INFO - Successfully installed simplejson 03:26:22 INFO - Cleaning up... 03:26:22 INFO - Return code: 0 03:26:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:26:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:22 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 0x25081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2874a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2878090>, '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 0x2878d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2872f90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1505556404.851400-389019985', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:26:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:26:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:26:22 INFO - Using env: {'DISPLAY': ':0', 03:26:22 INFO - 'HOME': '/home/cltbld', 03:26:22 INFO - 'LANG': 'en_US.UTF-8', 03:26:22 INFO - 'LANGUAGE': 'en_US:en', 03:26:22 INFO - 'LOGNAME': 'cltbld', 03:26:22 INFO - 'MAIL': '/var/mail/cltbld', 03:26:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:22 INFO - 'MOZ_NO_REMOTE': '1', 03:26:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:22 INFO - 'NO_EM_RESTART': '1', 03:26:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:22 INFO - 'PWD': '/builds/slave/test', 03:26:22 INFO - 'SHELL': '/bin/bash', 03:26:22 INFO - 'SHLVL': '1', 03:26:22 INFO - 'TERM': 'linux', 03:26:22 INFO - 'TMOUT': '86400', 03:26:22 INFO - 'USER': 'cltbld', 03:26:22 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1505556404.851400-389019985', 03:26:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:22 INFO - '_': '/tools/buildbot/bin/python'} 03:26:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:26:22 INFO - Cleaning up... 03:26:22 INFO - Return code: 0 03:26:22 INFO - Running post-action listener: _resource_record_post_action 03:26:22 INFO - Running post-action listener: _start_resource_monitoring 03:26:23 INFO - Starting resource monitoring. 03:26:23 INFO - [mozharness: 2017-09-16 10:26:23.007898Z] Finished create-virtualenv step (success) 03:26:23 INFO - [mozharness: 2017-09-16 10:26:23.008361Z] Running install step. 03:26:23 INFO - Running pre-action listener: _resource_record_pre_action 03:26:23 INFO - Running main action method: install 03:26:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:26:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:26:23 INFO - Reading from file tmpfile_stdout 03:26:23 INFO - Detecting whether we're running mozinstall >=1.0... 03:26:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:26:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:26:23 INFO - Reading from file tmpfile_stdout 03:26:23 INFO - Output received: 03:26:23 INFO - Usage: mozinstall [options] installer 03:26:23 INFO - Options: 03:26:23 INFO - -h, --help show this help message and exit 03:26:23 INFO - -d DEST, --destination=DEST 03:26:23 INFO - Directory to install application into. [default: 03:26:23 INFO - "/builds/slave/test"] 03:26:23 INFO - --app=APP Application being installed. [default: firefox] 03:26:23 INFO - mkdir: /builds/slave/test/build/application 03:26:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:26:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:26:41 INFO - Reading from file tmpfile_stdout 03:26:41 INFO - Output received: 03:26:41 INFO - /builds/slave/test/build/application/firefox/firefox 03:26:41 INFO - Running post-action listener: _resource_record_post_action 03:26:41 INFO - [mozharness: 2017-09-16 10:26:41.154055Z] Finished install step (success) 03:26:41 INFO - [mozharness: 2017-09-16 10:26:41.154200Z] Running setup-mitmproxy step. 03:26:41 INFO - Running pre-action listener: _resource_record_pre_action 03:26:41 INFO - Running main action method: setup_mitmproxy 03:26:41 INFO - Skipping: mitmproxy is not required 03:26:41 INFO - Running post-action listener: _resource_record_post_action 03:26:41 INFO - [mozharness: 2017-09-16 10:26:41.154740Z] Finished setup-mitmproxy step (success) 03:26:41 INFO - [mozharness: 2017-09-16 10:26:41.154843Z] Running run-tests step. 03:26:41 INFO - Running pre-action listener: _resource_record_pre_action 03:26:41 INFO - Running pre-action listener: _set_gcov_prefix 03:26:41 INFO - Running main action method: run_tests 03:26:41 WARNING - Try message not found. 03:26:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:26:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:26:41 INFO - Python 2.7.3 03:26:41 INFO - Return code: 0 03:26:41 INFO - grabbing minidump binary from tooltool 03:26:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:41 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 0x2878090>, '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 0x2878d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2872f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:26:41 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:26:41 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:26:41 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:26:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:26:41 INFO - Return code: 0 03:26:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:26:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:26:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:26:41 INFO - ENV: RUST_BACKTRACE is now full 03:26:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:26:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:26:41 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/QKXeurjvQniffQGOJwEu5g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 03:26:41 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/QKXeurjvQniffQGOJwEu5g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 03:26:41 INFO - Using env: {'DISPLAY': ':0', 03:26:41 INFO - 'HOME': '/home/cltbld', 03:26:41 INFO - 'LANG': 'en_US.UTF-8', 03:26:41 INFO - 'LANGUAGE': 'en_US:en', 03:26:41 INFO - 'LOGNAME': 'cltbld', 03:26:41 INFO - 'MAIL': '/var/mail/cltbld', 03:26:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:26:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:26:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:41 INFO - 'MOZ_NO_REMOTE': '1', 03:26:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:26:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:41 INFO - 'NO_EM_RESTART': '1', 03:26:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:41 INFO - 'PWD': '/builds/slave/test', 03:26:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:26:41 INFO - 'RUST_BACKTRACE': 'full', 03:26:41 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:26:41 INFO - 'SHELL': '/bin/bash', 03:26:41 INFO - 'SHLVL': '1', 03:26:41 INFO - 'TERM': 'linux', 03:26:41 INFO - 'TMOUT': '86400', 03:26:41 INFO - 'USER': 'cltbld', 03:26:41 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1505556404.851400-389019985', 03:26:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:41 INFO - '_': '/tools/buildbot/bin/python'} 03:26:41 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/QKXeurjvQniffQGOJwEu5g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 03:26:41 INFO - mozversion application_buildid: 20170916093526 03:26:41 INFO - mozversion application_changeset: 27e7b4261e4b5a016e09adb5332a181e43ab520e 03:26:41 INFO - mozversion application_display_name: Nightly 03:26:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:26:41 INFO - mozversion application_name: Firefox 03:26:41 INFO - mozversion application_remotingname: firefox 03:26:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:26:41 INFO - mozversion application_vendor: Mozilla 03:26:41 INFO - mozversion application_version: 57.0a1 03:26:41 INFO - mozversion platform_buildid: 20170916093526 03:26:41 INFO - mozversion platform_changeset: 27e7b4261e4b5a016e09adb5332a181e43ab520e 03:26:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:26:41 INFO - mozversion platform_version: 57.0a1 03:26:41 INFO - using testdate: 1505557601 03:26:41 INFO - actual date: 1505557601 03:26:41 INFO - starting webserver on 'localhost:47931' 03:26:41 INFO - SUITE-START | Running 2 tests 03:26:41 INFO - TEST-START | dromaeo_css 03:26:41 INFO - Initialising browser for dromaeo_css test... 03:26:41 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47931/getInfo.html -profile /tmp/tmp7r95Sp/profile 03:26:41 INFO - TEST-INFO | started process 9657 (/builds/slave/test/build/application/firefox/firefox http://localhost:47931/getInfo.html) 03:26:47 INFO - TEST-INFO | 9657: exit 0 03:26:47 INFO - Browser initialized. 03:26:47 INFO - Running cycle 1/1 for dromaeo_css test... 03:26:47 INFO - Using env: {'DISPLAY': ':0', 03:26:47 INFO - 'HOME': '/home/cltbld', 03:26:47 INFO - 'JSGC_DISABLE_POISONING': '1', 03:26:47 INFO - 'LANG': 'en_US.UTF-8', 03:26:47 INFO - 'LANGUAGE': 'en_US:en', 03:26:47 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:26:47 INFO - 'LOGNAME': 'cltbld', 03:26:47 INFO - 'MAIL': '/var/mail/cltbld', 03:26:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:26:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:26:47 INFO - 'MOZ_CRASHREPORTER': '1', 03:26:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:47 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:26:47 INFO - 'MOZ_NO_REMOTE': '1', 03:26:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:26:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:47 INFO - 'NO_EM_RESTART': '1', 03:26:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:47 INFO - 'PWD': '/builds/slave/test', 03:26:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:26:47 INFO - 'RUST_BACKTRACE': 'full', 03:26:47 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:26:47 INFO - 'SHELL': '/bin/bash', 03:26:47 INFO - 'SHLVL': '1', 03:26:47 INFO - 'TERM': 'linux', 03:26:47 INFO - 'TMOUT': '86400', 03:26:47 INFO - 'USER': 'cltbld', 03:26:47 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1505556404.851400-389019985', 03:26:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:47 INFO - '_': '/tools/buildbot/bin/python'} 03:26:47 INFO - TEST-INFO | started process 9891 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7r95Sp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:26:48 INFO - PID 9891 | 03:26:48 INFO - PID 9891 | (/builds/slave/test/build/application/firefox/firefox:9940): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:26:48 INFO - PID 9891 | 03:26:58 INFO - PID 9891 | RSS: Main: 155332608 03:26:58 INFO - PID 9891 | 03:29:56 INFO - PID 9891 | Cycle 1(1): loaded http://localhost:47931/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47931/tests/dromaeo/cssquery-ext.html) 03:29:57 INFO - PID 9891 | RSS: Main: 155623424 03:29:57 INFO - PID 9891 | 03:32:59 INFO - PID 9891 | Cycle 1(1): loaded http://localhost:47931/tests/dromaeo/cssquery-ext.html (next: http://localhost:47931/tests/dromaeo/cssquery-jquery.html) 03:32:59 INFO - PID 9891 | RSS: Main: 154710016 03:32:59 INFO - PID 9891 | 03:36:01 INFO - PID 9891 | Cycle 1(1): loaded http://localhost:47931/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47931/tests/dromaeo/cssquery-mootools.html) 03:36:02 INFO - PID 9891 | RSS: Main: 158302208 03:36:02 INFO - PID 9891 | 03:39:03 INFO - PID 9891 | Cycle 1(1): loaded http://localhost:47931/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47931/tests/dromaeo/cssquery-prototype.html) 03:39:04 INFO - PID 9891 | RSS: Main: 156889088 03:39:04 INFO - PID 9891 | 03:42:07 INFO - PID 9891 | Cycle 1(1): loaded http://localhost:47931/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47931/tests/dromaeo/cssquery-yui.html) 03:42:08 INFO - PID 9891 | RSS: Main: 157491200 03:42:08 INFO - PID 9891 | 03:45:09 INFO - PID 9891 | Cycle 1(1): loaded http://localhost:47931/tests/dromaeo/cssquery-yui.html (next: http://localhost:47931/tests/dromaeo/cssquery-dojo.html) 03:45:10 INFO - PID 9891 | RSS: Main: 157175808 03:45:10 INFO - PID 9891 | 03:45:10 INFO - PID 9891 | __start_tp_report 03:45:10 INFO - PID 9891 | _x_x_mozilla_page_load 03:45:10 INFO - PID 9891 | _x_x_mozilla_page_load_details 03:45:10 INFO - PID 9891 | |i|pagename|runs| 03:45:10 INFO - PID 9891 | |0;dojo.html;3060.34202646431;3075.661677215507;3102.860371283293;3113.2061324362285;3127.984360078199;6064.211652485182;6115.266168059828;6120.571559990803;6145.078238264263;6197.380261973806;6121.632702037881;6184.474319682821;6227.190465239512;6239.220097487814;6246.656433896134;5623.437656234385;5695.77216911323;5700.3159620845345;5701.572382071351;5798.971005144989;5776.508996735282;5800.013997620415;5803.883922321572;5810.041343178371;5829.417058294179;5738.368779434259;5785.768569257246;5803.767849286023;5811.128330750379;5848.035074212771;5566.4990150886615;5633.8309850704545;5705.058665320217;5772.6536407815665;5831.533477321804;5652.208690783294;5693.3452652945025;5732.426757324234;5738.110592858114;5750.626209296424;6127.785527506516;6209.627422354673;6224.533160012972;6247.9687601562155;6306.87386252277;6446.548741588043;6556.770513032068;6570.704318305688;6720.361565651256;6722.83192920176;6525.836854078686;6761.121054262963;6764.729410823561;6767.255601883789;6772.458203343721;6033.909491357633;6191.2570491540855;6226.564140510166;6249.812505624838;6265.686715664244;6789.355011273921;6879.5184337096925;6942.93057069433;6957.721691132298;6962.1645402551;6365.172527571386;6433.228012638513;6495.285518592951;6563.835904102436;6646.102776125258;6695.631740254333;6708.228553716288;6719.596824190564;6724.7646332378135;6760.256371799098;6633.502487313374;6645.966770166118;6653.434458071021;6718.832029199211;6752.83117922046;6500.122483464766;6667.166604174478;6673.899891501631;6748.966255168692;6758.05387245786;5238.030964271622;5238.7904483820985;5239;5242.213667949762;5249.895002099936;4550.953280745381;4567.611753000966;4574.862754117382;4579.267317229227;4584.220682483986;5691.943080569225;5734.311882574035;5777.075667893117;5804.88390232193;5815.73829177688;6649.434798042221;6722.9663851680425;6724.4284235840505;6736.292689267556;6748.291429399842;5693.743781529758;5696.914546281809;5758.596898217168;5764.827055188351;5787.305523337226;5639.351474580476;5725;5760.395158508296;5797.88404231913;5812.505936995318;6459.515536334794;6504.804855854332;6506.1541999540705;6536.803895883131;6546.116274303004;6663.766768163091;6664.100346453264;6747.493937954575;6764.661766911537;6778.356056174655;6366.236051673829;6404.871902562016;6426.164598602339;6449.064885591657;6518.73925042993;6611.338866113542;6615.04081908111;6615.206175258807;6632.933670663425;6674.833129171615;6622.602643841385;6704.094947182068;6780.93219067803;6790.83022924411;6806.659667016728;6417.7753778617525;6452.451541618827;6494.967525162344;6503.869922601616;6518.934810651833;6335.588186767845;6412.583182093149;6431.292557818542;6473.676316184078;6487.156669632917;6361.8727625448155;6424.871502570016;6431.839204019937;6432.292447830641;6484.513661475314;6428.389303016206;6540.542162048611;6577.736890524326;6594.076829244005;6599.967000164968;6116.5106791457465;6285;6365.395287447685;6391.265004524539;6397.96801015992 03:45:10 INFO - PID 9891 | |1;ext.html;840.3907167303702;851.7317045130783;855.1533981358457;858.8926384201975;867.8067656971666;39990.800045999764;40803;41253.381199282;41260;41328.79335603325;37545;37609.24781504375;37717.245655086954;37723;37778.622213777926;7013.544119632207;7078.186008608998;7082.150141982944;7083;7089.468289878254;7041.753538626149;7122.1453425589;7140.32166944142;7153.785386438415;7165.283471652845;7669.923300766976;7831.138574756772;7840.960795196016;7868.724594639189;7876.684932602689;7764.456488045839;7798.688052477894;7829.921700782977;7855.41084418668;7874.960625196894;7566.205548417447;7630.236976302325;7717.344025757818;7747.496412733154;7759.961200193963;37152.44271335932;37414;37499;37644.81177594094;37683.62316376856;3425.383430982422;3459.377312083824;3479.4085005548864;3482.094655389617;3501.77238479498;30720.84639576788;30778.53832192519;30811.69188308133;30834;30869.845650771826;5070.670406423571;5188.533032027098;5214;5236.764345604419;5344.385395679507;179966;180789;181428;181684.9999999987;181734;46604;46898.53101468942;46925.5307446928;46925.82685432823;46940;48107;48379.75810120927;48661.5133848657;48701.756491218024;48900.755496223006;15812.841871581368;16105.597360066093;16108.516744497683;16114.597135071717;16155.596110097342;13231.536896208587;13307;13346.666333341744;13363;13364.866351336363;13887.513937012358;13956.09285396446;13998.510052148125;14025.71948561023;14074.788878166835;5860.472557469848;5927.911081333697;5951.702414879239;5997;6010.248718910137;1011.4234886114843;1013.2299452416216;1014.7666036811427;1018.5263852308564;1040.2042437535292;22590.532297067355;22736.43158921007;22870.313890583308;22908.08367665308;22932.541349172923;1114.225613198819;1119.1941801902617;1121.6522877907876;1128.1933417606288;1131.6491887514896;11850.288982661068;11935.641930742091;11959.222650527689;11992.400379980965;12039;220047;222458;222569;223050;223155;51812.74093629508;52150.217746733826;54232.72883635556;55540.16689749657;55925.7203713987;1399.230423267199;1430.8569143085608;1443.6174413780357;1447.7466443372368;1453.2515754386711;26390.340241494116;26416.8679156603;26787.33031674224;26802.731972680023;26937.191884243504;36758.44862327014;36793.816030919676;36810.26379472342;36885;36914;186235;187210;187679;188446;188707;31965.68034319627;32137.517937230492;32181.839090804395;32365.676343236268;32550;39565;40560;40874.38688419617;40970.59029409787;41125.588744112174;30160.09519714412;30529.54205686961;30676.539851902686;31040.223994399417;31380.215494612818;30119.849400752857;30288.242793930327;30387.848060759556;31176.532352014285;31345.52981705322;32923.67076329206;33978.660213398536;34035.319293613495;34052.31895362029;34082.82958585191;30214.54678179785;30522.542161867146;30528.694713053475;31005.379892401575;31544.36911261716;21934.45163870916;22037.11851525921;22040;22083.33749987503;22171.556568868855 03:45:10 INFO - PID 9891 | |2;jquery.html;554.1632135475431;563.8505795964073;574.4686165297102;578.6470253145582;596.6181643748002;21914.45213869654;22481.55036899263;22696.9786359614;22727.977241024153;22738.431539211528;23523.882380588075;24439.266821995323;24519.50960980784;24659.75340246597;24816.255512334614;6337.809865704036;6563.245226798931;6575.572587781779;6581.506387020969;6582.078509008718;6429.260635026962;6547.083408322838;6547.181602299713;6556.409923106919;6565.80302590923;6159.353267906872;6420.486361091125;6422.646754428504;6426.518011149159;6431.356864313578;6350.936490635127;6394.200724909387;6395.104685344056;6427.903581446282;6448.065030570588;5753.194552762617;5917.763289468416;6019.578629495937;6031.1254868044325;6041.033434650435;27570.448591028267;27954.580681289797;27995.86002069997;27999.440011199866;28008;1957.980420195794;2001.9299324523718;2002.5594369238745;2004.7393838800863;2009.4875806669352;18905.527361815926;19200.231990720353;19506.512337191543;19523.609527809505;19558.217671293132;2357.870317132557;2416.5287768885073;2420.9394765130837;2448.0574978633176;2468.148488771389;128864;134043.32978335142;134071;135903;136512.31743841316;14736.600022997798;14847.480338188112;14940.730037946896;14999.250037498081;15254.694906101815;22519.437014074778;22521.662175067388;22563.88718056432;22605.321840344815;22607.321780346614;10207.795844083077;10209.489525523843;10259.897401026043;10347.63783267582;10493.685189444328;9532.378595886186;9623.470709110927;9672.70981870545;9678.225741940629;9715.417074975525;8595.398322117391;9023.458592484472;9086.818263634823;9136.725898223063;9181.77045573866;2434.3914021494625;2466.4080620650916;2500;2500.2874180858366;2622.0822712051013;955.5031383680447;961.1733908838394;966.415318732157;986.9834070906977;988.8961659025842;18417.723734143998;18566.164522596246;18661.81338186628;18963.336283230296;19072.427827165207;1025.564135242519;1037.227265687053;1039.3036665434176;1048.5111142178125;1048.528162326956;10108.191344692406;10277.588896444207;10402.27184097121;10546.839847616757;10561.63034293796;446544.46965229505;449247;451325;456814;460800;107496.46251768692;108083.45958270159;110104.4494777521;110856.4457177709;112061.43969280101;1133.1161693878953;1138.5407519757284;1159.1016961854461;1161.1929708852267;1169.222467059413;16584.253708582903;16617.252223649724;16642;16708.16459177012;16734.49796506107;56567.71716141393;57333;58112.70943645255;59257.70371148117;60206.69896650489;74666.62666686632;74787;75651.24348756662;76157.61921190358;76294.61852690922;12819.294938778457;13737.656558585715;13949.442022318994;13950.651233719238;13964.511242106477;21611.459713507287;21883.562328753655;21913.342599722033;21967.780322196573;22157.1137154512;17410.564735881704;17672.028038457494;17729.11354432299;17959.01225432614;17973.37093201732;15738.740900727686;15935.20323983773;16257.268422921234;16283.430079947146;16536.338546458006;16763.329466821677;17526.474205773848;17542.21060052275;17631.82368176353;17659.55851103733;13579.86420135786;13783.173009619455;13831.30843457803;13852.238126903118;13868.72262554723;16825.41111061107;16897.239624216694;17007.659846803243;17019;17384 03:45:10 INFO - PID 9891 | |3;mootools.html;1307.339793404331;1362.8773410393067;1366.8199222240523;1366.8564800695926;1382.1776043254267;15034.77447838282;15794.210289485538;15794.36822527099;15798.131102789328;15812.367505299775;15397.307121179545;15504.534863954072;15506.302216400261;15533.456329028459;15572;2674.638923745289;2686.1001564475873;2740.328619488218;2746.121241202816;2750.601162831398;2729.140320798942;2759.103291430283;2769.363046499306;2771.7921155913386;2778.3470884342164;2608.373990242347;2633.104744386908;2749.6975332713387;2750.106215479967;2751.2159034675124;2689.2201261634104;2712.91861244163;2736.904208352708;2739.8767055482454;2742.437800250944;2557.9488410231693;2634.6574945256993;2655.137080448862;2658;2674.304680782991;15354.846451535564;15474.148921809408;15505.534833955;15532.223388830625;15535.300911459011;8056.476329038594;8272.503649781032;8340.582970851434;8383.371247156487;8390.32877369809;5524.640898341595;5624.903143886943;5702.714864256771;5750.482456578886;5781.913271300934;1908.4560900143392;1928.9131989060527;1940.5439721665398;1950.3173889138689;1970.448274483147;26706;26854.462910741677;26899;26944.46111077787;26954.5956810648;6672.933270667231;6785.253622101565;6831.180258368928;6989.650517474106;6994.475414343945;17286.567835804206;17287.481375558753;17300.826991729922;17308.221130049176;17329.133543322783;7836.804079897935;7986.440949133621;7990.360771138295;7994.360451163893;7997.040355157302;7223.747168849065;7356.190819009905;7384.335409813142;7474.5888976106835;7493.887591686129;4935.333729946483;5077.543021128116;5113.233015047773;5142.202958541432;5157.303763991813;1527.923603819827;1528.6866192430525;1533.1031346662328;1545.296889915086;1564.2022568489924;849.4987957105337;862.491130233153;883.3021912689032;885.5306687455659;889.1908363389284;7315.122185337794;8618.698345557876;8776.297896168291;8840.602172902234;8853.69012084574;630.1713247080075;658.4896705053621;659.9109120268798;660.7819419591523;664.3522565498697;4763.499832517605;5261.210818377198;5307.734613269321;5391.514763671288;5439.972800135974;21222.575548489254;21820.672689909665;22059.889700551714;22218.222362217246;22275.443113922283;20670.58658826815;21878.671819922714;21881.234156804436;22107.447313816963;22189.556208876056;10951.123910087334;11078.778424431628;11140.665780026613;11148.944255278833;11356.48895799691;8307.127751585997;8334.999800024036;8363.665453381796;8407.537585432616;8535.914640853513;18581.44255672332;18862;19000.809991899903;19144.329948451737;19267.710984334964;19201.903990479957;19352.225910963403;19425.611487769882;19439.12523936398;19523.414297571097;10957.726056848642;11162.162837787037;11170.776584468427;11171.608993685182;11185.32888026721;13288.933555332162;13317.33413329349;13328.200307981551;13348.132371396217;13428.261445620585;10777.515011824644;10819.94421059996;11113.499892504695;11123.721906952067;11311;11064;11081.501332439899;11308.943455282671;11402.144839136932;11471.655850324503;10125.139363154214;10321;10325.122364599094;10335.22485813582;10335.534900929326;7383.667734952048;7449.553026818191;7451.3666338361845;7519.774406767806;7531.548107113591;7349.375303099083;7505.737299194502;7556.773296801105;7632.961835190788;7702.5763583001235 03:45:10 INFO - PID 9891 | |4;prototype.html;507.5564569986891;512.6923845692583;519.2756105233198;521.449870386742;536.6887205420855;6290.119383286338;6326.936730632692;6329.746810127601;6343.777967771129;6373.426391624747;6173.50611951044;6233.875322493547;6255.687215639223;6258.311585725566;6299.181106456166;5194.454582268864;5196.662216955895;5220.477952204768;5224.29472021278;5227;4781.37842080529;4974.228994505839;5200.167973124301;5200.843974680765;5225.503577160163;4896.485868983741;4941.77762000709;4997.42529609096;5007.724575148365;5017.824376146836;4917.655764096515;4926.655134140611;4960.355153830015;4967;4985.476524964899;4422.15978963999;4422.579854913778;4446.42196514451;4450.399196108517;4453.220686379903;6125.938740612626;6166.907496387557;6190.350013248589;6197.16338294329;6213.596116252429;5661.886762264773;5677.489025987681;5680.4319568043275;5713.542916566665;5726.3700992890745;6457.062881135687;6458.967705161444;6461.8061458156335;6504.707288172043;6521.478281737497;4794.113089078532;4819.228923372244;4840.854774356775;4863.294822250754;4874.610031197496;6615.569987950767;6766.28953959837;6797.6601169941305;6889.3455121763855;6930.896036559456;4981.750912454435;4986.509443389642;5004.124278251292;5013.37065453729;5014.6991180529285;5008.29883816266;5054.4078615236085;5071.619628527875;5081.796728130834;5093.465186155475;5648.830535083954;5682.40334764852;5690.715464226772;5702;5711.7719690266795;6622.337766223339;6623.86752264952;6625.436837868835;6641.535092543476;6644.66776661165;1753.4038426934903;1759.4369801663345;1762.8325309095615;1766.2493440287826;1769.5841477252836;1121.3216004317433;1191.3090407563766;1203.1638011581867;1214.7509760499076;1217.34263497712;5663.377028526858;5681.176229446707;5706.857328566819;5728.513076388554;5740.7277851625;6659.4006539411685;6680.966595166993;6690.264070952191;6726.630035348005;6760.864782704319;5571.303587051619;5635.6618602883955;5646.407127251579;5679.971600141973;5700.572457065654;3494.0475298372835;3508.8947331580093;3550.25444656625;3553.9289214216087;3559.4660800880074;6386.840328991812;6395.296517383084;6400.359964003563;6472.15861937945;6510.381513756186;6731.865362692816;6763.0193621924545;6850.040994260808;6850.6574671266235;6874.8625027500175;6340.968295158495;6396.42432181106;6408.455281300955;6417.1657684500715;6430.80707578764;6061.242344706911;6572.211334639874;6586.769463068769;6616.536842420985;6641.236257830411;6451.741930322734;6458.38645328693;6541;6633.2371777246235;6648.16897887764;6388.520860935356;6399.776007839703;6404.295527491879;6415.71129299192;6438.420542151229;4881.804727810848;4964.726940018189;4978.8755281118265;4989.925151122663;5008.373953255843;6495.707693153914;6547.345265473415;6674.364780628777;6747.156605424322;6785.59286442815;6435.420812126931;6441.323661015525;6441.838954026187;6450.258640078042;6477.643729594917;6543.149390579194;6569.9343006571235;6571.934280657132;6583.3087525811015;6592.208934927839;6415.422611964946;6437.613743175424;6460.8707825842275;6508.772192973223;6517.502922983126;6586.242582103119;6607.636579988147;6608.70260838273;6609.239937407259;6617.900731488935;6313.873722525615;6337.510684988932;6354.618722876642;6368.4586810121655;6419 03:45:10 INFO - PID 9891 | |5;yui.html;884.9690260840872;900.1403659505173;919.793046564523;921.728090213387;934.5934518484462;19047;19767.308144214956;19905.303314384;20001.899990500064;20013.899930500327;18082.63834723308;18359.265629374844;18405.44783656489;18698.813011869875;18801.623967520674;935.7192842147363;953.1231267234161;954.6467806911453;956.5552018311483;960.6829746183778;955.5843208204418;964.6575465709677;965.7923546437514;970.3547141151126;990.301837204769;1059.4543809937888;1061.5170097605571;1064.8136576099191;1066.9466526673675;1070.2508244229032;987.274353350287;1057.6668349469892;1061.851340812287;1063.3194755356578;1068.1668298727006;734.0970606154407;735.8270806360501;739.7484855149221;745.80981849628;748.1620584944842;18874.905625471783;19021.239150433965;19218.615627687366;19324.613507729908;19327.51681207967;21889.562208755895;22108.778912210833;22668.659970100463;22787.08851645932;22825.657615135788;16391.426300079558;17010;17032.82967170325;17168.91415542927;17174.22715977784;3741.30785804627;3795.6773674237725;3800.562935262425;3806.5812760596314;3808.9428658570146;145156;145772.2711386447;146326;148362;150682.24658876745;16248;16448.259828307517;16473.34106635745;16491.257893394824;16522.917385413235;26650.466990660465;27068.729312707015;27081.052163174194;27138.321541961213;27571.724282756917;8580.227779499875;8589.52757598338;8606.31149508038;8613.96632404103;8638.17937295956;3635.4365073413665;3651;3671.5227020487164;3687.870924517629;3703.166787472797;5498.202760599691;5531.529819965268;5540.750666220029;5587.8824235152315;5606.243157173811;972.8443449048118;989.9604015839429;1001.1990407673832;1006.2805094357569;1009.2279406254221;700.684691888642;706.3184027413571;707.1125737199884;716.2085895085959;729.1214087025122;10478;10850.511726972305;10954.452277386099;11025.83461248082;11099.72250693739;697.7243988624465;704.9013138160661;717.9676914538858;719.7660760252938;722.7867779005206;5181.35233095863;5193.532582067632;5322.680639161663;5358.5981051421295;5404.32445944257;113169;115540.42229788797;118262;118776.40611796886;119775;105343;107325;107924;111262.44368778267;112393.43803281095;91161.54419227861;92187;95319.52340238393;95324;95810;9789.97205293434;9874.963128871364;10053.04496072872;10061.849072263776;10159.796804064024;45317.77341113273;45385.54614453813;46669.299960501296;46748.29877551908;46827.765861171836;57754.422455776585;58789.41210587839;59197;59610;59869.101963471454;15840.60398490047;15874.761878572062;15878.52364429069;15906.920465398061;16001.199940003185;16715.164241788105;16745.162741863103;16832.915835420743;16937.661246775242;17066.232019559397;15754.133522656364;16141;16181.029138251743;16350.427735029218;16378.344866205218;15169.165695886832;15421.383144674535;15424.46014389491;15499.457518987232;15637.609059773597;15130.470433534774;15178.848211517743;15262.236888155327;15346.079235245921;15566.37734490653;11006.229563930448;11031.779364412827;11075.778484430106;11418.086553075567;11467.082633389477;10737;10787.244892857738;10927.945360273467;11138.498767555642;11255.493502792559 03:45:10 INFO - PID 9891 | __end_tp_report 03:45:10 INFO - PID 9891 | __start_cc_report 03:45:10 INFO - PID 9891 | _x_x_mozilla_cycle_collect,268 03:45:10 INFO - PID 9891 | __end_cc_report 03:45:10 INFO - PID 9891 | __startTimestamp1505558710093__endTimestamp 03:45:10 INFO - PID 9891 | 03:45:10 INFO - PID 9891 | ------- Summary: start ------- 03:45:10 INFO - PID 9891 | Number of tests: 6 03:45:10 INFO - PID 9891 | 03:45:10 INFO - PID 9891 | [#0] dojo.html Cycles:165 Average:6132.68 Median:6391.27 stddev:742.07 (11.6%) stddev-sans-first:704.12 03:45:10 INFO - PID 9891 | Values: 3060.3 3075.7 3102.9 3113.2 3128.0 6064.2 6115.3 6120.6 6145.1 6197.4 6121.6 6184.5 6227.2 6239.2 6246.7 5623.4 5695.8 5700.3 5701.6 5799.0 5776.5 5800.0 5803.9 5810.0 5829.4 5738.4 5785.8 5803.8 5811.1 5848.0 5566.5 5633.8 5705.1 5772.7 5831.5 5652.2 5693.3 5732.4 5738.1 5750.6 6127.8 6209.6 6224.5 6248.0 6306.9 6446.5 6556.8 6570.7 6720.4 6722.8 6525.8 6761.1 6764.7 6767.3 6772.5 6033.9 6191.3 6226.6 6249.8 6265.7 6789.4 6879.5 6942.9 6957.7 6962.2 6365.2 6433.2 6495.3 6563.8 6646.1 6695.6 6708.2 6719.6 6724.8 6760.3 6633.5 6646.0 6653.4 6718.8 6752.8 6500.1 6667.2 6673.9 6749.0 6758.1 5238.0 5238.8 5239.0 5242.2 5249.9 4551.0 4567.6 4574.9 4579.3 4584.2 5691.9 5734.3 5777.1 5804.9 5815.7 6649.4 6723.0 6724.4 6736.3 6748.3 5693.7 5696.9 5758.6 5764.8 5787.3 5639.4 5725.0 5760.4 5797.9 5812.5 6459.5 6504.8 6506.2 6536.8 6546.1 6663.8 6664.1 6747.5 6764.7 6778.4 6366.2 6404.9 6426.2 6449.1 6518.7 6611.3 6615.0 6615.2 6632.9 6674.8 6622.6 6704.1 6780.9 6790.8 6806.7 6417.8 6452.5 6495.0 6503.9 6518.9 6335.6 6412.6 6431.3 6473.7 6487.2 6361.9 6424.9 6431.8 6432.3 6484.5 6428.4 6540.5 6577.7 6594.1 6600.0 6116.5 6285.0 6365.4 6391.3 6398.0 03:45:10 INFO - PID 9891 | 03:45:10 INFO - PID 9891 | [#1] ext.html Cycles:180 Average:36288.41 Median:33451.17 stddev:51187.65 (153.0%) stddev-sans-first:51262.04 03:45:10 INFO - PID 9891 | Values: 840.4 851.7 855.2 858.9 867.8 39990.8 40803.0 41253.4 41260.0 41328.8 37545.0 37609.2 37717.2 37723.0 37778.6 7013.5 7078.2 7082.2 7083.0 7089.5 7041.8 7122.1 7140.3 7153.8 7165.3 7669.9 7831.1 7841.0 7868.7 7876.7 7764.5 7798.7 7829.9 7855.4 7875.0 7566.2 7630.2 7717.3 7747.5 7760.0 37152.4 37414.0 37499.0 37644.8 37683.6 3425.4 3459.4 3479.4 3482.1 3501.8 30720.8 30778.5 30811.7 30834.0 30869.8 5070.7 5188.5 5214.0 5236.8 5344.4 179966.0 180789.0 181428.0 181685.0 181734.0 46604.0 46898.5 46925.5 46925.8 46940.0 48107.0 48379.8 48661.5 48701.8 48900.8 15812.8 16105.6 16108.5 16114.6 16155.6 13231.5 13307.0 13346.7 13363.0 13364.9 13887.5 13956.1 13998.5 14025.7 14074.8 5860.5 5927.9 5951.7 5997.0 6010.2 1011.4 1013.2 1014.8 1018.5 1040.2 22590.5 22736.4 22870.3 22908.1 22932.5 1114.2 1119.2 1121.7 1128.2 1131.6 11850.3 11935.6 11959.2 11992.4 12039.0 220047.0 222458.0 222569.0 223050.0 223155.0 51812.7 52150.2 54232.7 55540.2 55925.7 1399.2 1430.9 1443.6 1447.7 1453.3 26390.3 26416.9 26787.3 26802.7 26937.2 36758.4 36793.8 36810.3 36885.0 36914.0 186235.0 187210.0 187679.0 188446.0 188707.0 31965.7 32137.5 32181.8 32365.7 32550.0 39565.0 40560.0 40874.4 40970.6 41125.6 30160.1 30529.5 30676.5 31040.2 31380.2 30119.8 30288.2 30387.8 31176.5 31345.5 32923.7 33978.7 34035.3 34052.3 34082.8 30214.5 30522.5 30528.7 31005.4 31544.4 21934.5 22037.1 22040.0 22083.3 22171.6 03:45:10 INFO - PID 9891 | 03:45:10 INFO - PID 9891 | [#2] jquery.html Cycles:180 Average:33247.63 Median:22319.33 stddev:76720.60 (343.7%) stddev-sans-first:76896.56 03:45:10 INFO - PID 9891 | Values: 554.2 563.9 574.5 578.6 596.6 21914.5 22481.6 22697.0 22728.0 22738.4 23523.9 24439.3 24519.5 24659.8 24816.3 6337.8 6563.2 6575.6 6581.5 6582.1 6429.3 6547.1 6547.2 6556.4 6565.8 6159.4 6420.5 6422.6 6426.5 6431.4 6350.9 6394.2 6395.1 6427.9 6448.1 5753.2 5917.8 6019.6 6031.1 6041.0 27570.4 27954.6 27995.9 27999.4 28008.0 1958.0 2001.9 2002.6 2004.7 2009.5 18905.5 19200.2 19506.5 19523.6 19558.2 2357.9 2416.5 2420.9 2448.1 2468.1 128864.0 134043.3 134071.0 135903.0 136512.3 14736.6 14847.5 14940.7 14999.3 15254.7 22519.4 22521.7 22563.9 22605.3 22607.3 10207.8 10209.5 10259.9 10347.6 10493.7 9532.4 9623.5 9672.7 9678.2 9715.4 8595.4 9023.5 9086.8 9136.7 9181.8 2434.4 2466.4 2500.0 2500.3 2622.1 955.5 961.2 966.4 987.0 988.9 18417.7 18566.2 18661.8 18963.3 19072.4 1025.6 1037.2 1039.3 1048.5 1048.5 10108.2 10277.6 10402.3 10546.8 10561.6 446544.5 449247.0 451325.0 456814.0 460800.0 107496.5 108083.5 110104.4 110856.4 112061.4 1133.1 1138.5 1159.1 1161.2 1169.2 16584.3 16617.3 16642.0 16708.2 16734.5 56567.7 57333.0 58112.7 59257.7 60206.7 74666.6 74787.0 75651.2 76157.6 76294.6 12819.3 13737.7 13949.4 13950.7 13964.5 21611.5 21883.6 21913.3 21967.8 22157.1 17410.6 17672.0 17729.1 17959.0 17973.4 15738.7 15935.2 16257.3 16283.4 16536.3 16763.3 17526.5 17542.2 17631.8 17659.6 13579.9 13783.2 13831.3 13852.2 13868.7 16825.4 16897.2 17007.7 17019.0 17384.0 03:45:10 INFO - PID 9891 | 03:45:10 INFO - PID 9891 | [#3] mootools.html Cycles:180 Average:9424.92 Median:14682.00 stddev:6766.40 (46.1%) stddev-sans-first:6757.89 03:45:10 INFO - PID 9891 | Values: 1307.3 1362.9 1366.8 1366.9 1382.2 15034.8 15794.2 15794.4 15798.1 15812.4 15397.3 15504.5 15506.3 15533.5 15572.0 2674.6 2686.1 2740.3 2746.1 2750.6 2729.1 2759.1 2769.4 2771.8 2778.3 2608.4 2633.1 2749.7 2750.1 2751.2 2689.2 2712.9 2736.9 2739.9 2742.4 2557.9 2634.7 2655.1 2658.0 2674.3 15354.8 15474.1 15505.5 15532.2 15535.3 8056.5 8272.5 8340.6 8383.4 8390.3 5524.6 5624.9 5702.7 5750.5 5781.9 1908.5 1928.9 1940.5 1950.3 1970.4 26706.0 26854.5 26899.0 26944.5 26954.6 6672.9 6785.3 6831.2 6989.7 6994.5 17286.6 17287.5 17300.8 17308.2 17329.1 7836.8 7986.4 7990.4 7994.4 7997.0 7223.7 7356.2 7384.3 7474.6 7493.9 4935.3 5077.5 5113.2 5142.2 5157.3 1527.9 1528.7 1533.1 1545.3 1564.2 849.5 862.5 883.3 885.5 889.2 7315.1 8618.7 8776.3 8840.6 8853.7 630.2 658.5 659.9 660.8 664.4 4763.5 5261.2 5307.7 5391.5 5440.0 21222.6 21820.7 22059.9 22218.2 22275.4 20670.6 21878.7 21881.2 22107.4 22189.6 10951.1 11078.8 11140.7 11148.9 11356.5 8307.1 8335.0 8363.7 8407.5 8535.9 18581.4 18862.0 19000.8 19144.3 19267.7 19201.9 19352.2 19425.6 19439.1 19523.4 10957.7 11162.2 11170.8 11171.6 11185.3 13288.9 13317.3 13328.2 13348.1 13428.3 10777.5 10819.9 11113.5 11123.7 11311.0 11064.0 11081.5 11308.9 11402.1 11471.7 10125.1 10321.0 10325.1 10335.2 10335.5 7383.7 7449.6 7451.4 7519.8 7531.5 7349.4 7505.7 7556.8 7633.0 7702.6 03:45:10 INFO - PID 9891 | 03:45:10 INFO - PID 9891 | [#4] prototype.html Cycles:180 Average:5495.13 Median:6205.38 stddev:1534.58 (24.7%) stddev-sans-first:1492.53 03:45:10 INFO - PID 9891 | Values: 507.6 512.7 519.3 521.4 536.7 6290.1 6326.9 6329.7 6343.8 6373.4 6173.5 6233.9 6255.7 6258.3 6299.2 5194.5 5196.7 5220.5 5224.3 5227.0 4781.4 4974.2 5200.2 5200.8 5225.5 4896.5 4941.8 4997.4 5007.7 5017.8 4917.7 4926.7 4960.4 4967.0 4985.5 4422.2 4422.6 4446.4 4450.4 4453.2 6125.9 6166.9 6190.4 6197.2 6213.6 5661.9 5677.5 5680.4 5713.5 5726.4 6457.1 6459.0 6461.8 6504.7 6521.5 4794.1 4819.2 4840.9 4863.3 4874.6 6615.6 6766.3 6797.7 6889.3 6930.9 4981.8 4986.5 5004.1 5013.4 5014.7 5008.3 5054.4 5071.6 5081.8 5093.5 5648.8 5682.4 5690.7 5702.0 5711.8 6622.3 6623.9 6625.4 6641.5 6644.7 1753.4 1759.4 1762.8 1766.2 1769.6 1121.3 1191.3 1203.2 1214.8 1217.3 5663.4 5681.2 5706.9 5728.5 5740.7 6659.4 6681.0 6690.3 6726.6 6760.9 5571.3 5635.7 5646.4 5680.0 5700.6 3494.0 3508.9 3550.3 3553.9 3559.5 6386.8 6395.3 6400.4 6472.2 6510.4 6731.9 6763.0 6850.0 6850.7 6874.9 6341.0 6396.4 6408.5 6417.2 6430.8 6061.2 6572.2 6586.8 6616.5 6641.2 6451.7 6458.4 6541.0 6633.2 6648.2 6388.5 6399.8 6404.3 6415.7 6438.4 4881.8 4964.7 4978.9 4989.9 5008.4 6495.7 6547.3 6674.4 6747.2 6785.6 6435.4 6441.3 6441.8 6450.3 6477.6 6543.1 6569.9 6571.9 6583.3 6592.2 6415.4 6437.6 6460.9 6508.8 6517.5 6586.2 6607.6 6608.7 6609.2 6617.9 6313.9 6337.5 6354.6 6368.5 6419.0 03:45:10 INFO - PID 9891 | 03:45:10 INFO - PID 9891 | [#5] yui.html Cycles:180 Average:24178.70 Median:19547.41 stddev:35638.01 (182.3%) stddev-sans-first:35695.07 03:45:10 INFO - PID 9891 | Values: 885.0 900.1 919.8 921.7 934.6 19047.0 19767.3 19905.3 20001.9 20013.9 18082.6 18359.3 18405.4 18698.8 18801.6 935.7 953.1 954.6 956.6 960.7 955.6 964.7 965.8 970.4 990.3 1059.5 1061.5 1064.8 1066.9 1070.3 987.3 1057.7 1061.9 1063.3 1068.2 734.1 735.8 739.7 745.8 748.2 18874.9 19021.2 19218.6 19324.6 19327.5 21889.6 22108.8 22668.7 22787.1 22825.7 16391.4 17010.0 17032.8 17168.9 17174.2 3741.3 3795.7 3800.6 3806.6 3808.9 145156.0 145772.3 146326.0 148362.0 150682.2 16248.0 16448.3 16473.3 16491.3 16522.9 26650.5 27068.7 27081.1 27138.3 27571.7 8580.2 8589.5 8606.3 8614.0 8638.2 3635.4 3651.0 3671.5 3687.9 3703.2 5498.2 5531.5 5540.8 5587.9 5606.2 972.8 990.0 1001.2 1006.3 1009.2 700.7 706.3 707.1 716.2 729.1 10478.0 10850.5 10954.5 11025.8 11099.7 697.7 704.9 718.0 719.8 722.8 5181.4 5193.5 5322.7 5358.6 5404.3 113169.0 115540.4 118262.0 118776.4 119775.0 105343.0 107325.0 107924.0 111262.4 112393.4 91161.5 92187.0 95319.5 95324.0 95810.0 9790.0 9875.0 10053.0 10061.8 10159.8 45317.8 45385.5 46669.3 46748.3 46827.8 57754.4 58789.4 59197.0 59610.0 59869.1 15840.6 15874.8 15878.5 15906.9 16001.2 16715.2 16745.2 16832.9 16937.7 17066.2 15754.1 16141.0 16181.0 16350.4 16378.3 15169.2 15421.4 15424.5 15499.5 15637.6 15130.5 15178.8 15262.2 15346.1 15566.4 11006.2 11031.8 11075.8 11418.1 11467.1 10737.0 10787.2 10927.9 11138.5 11255.5 03:45:10 INFO - PID 9891 | -------- Summary: end -------- 03:45:10 INFO - PID 9891 | 03:45:10 INFO - TEST-INFO | 9891: exit 0 03:45:10 INFO - TEST-OK | dromaeo_css | took 1109258ms 03:45:10 INFO - TEST-START | kraken 03:45:10 INFO - Initialising browser for kraken test... 03:45:10 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47931/getInfo.html -profile /tmp/tmpCinOR8/profile 03:45:10 INFO - TEST-INFO | started process 10257 (/builds/slave/test/build/application/firefox/firefox http://localhost:47931/getInfo.html) 03:45:16 INFO - TEST-INFO | 10257: exit 0 03:45:16 INFO - Browser initialized. 03:45:16 INFO - Running cycle 1/1 for kraken test... 03:45:16 INFO - Using env: {'DISPLAY': ':0', 03:45:16 INFO - 'HOME': '/home/cltbld', 03:45:16 INFO - 'JSGC_DISABLE_POISONING': '1', 03:45:16 INFO - 'LANG': 'en_US.UTF-8', 03:45:16 INFO - 'LANGUAGE': 'en_US:en', 03:45:16 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:45:16 INFO - 'LOGNAME': 'cltbld', 03:45:16 INFO - 'MAIL': '/var/mail/cltbld', 03:45:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:45:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:45:16 INFO - 'MOZ_CRASHREPORTER': '1', 03:45:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:16 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:45:16 INFO - 'MOZ_NO_REMOTE': '1', 03:45:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:45:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:16 INFO - 'NO_EM_RESTART': '1', 03:45:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:16 INFO - 'PWD': '/builds/slave/test', 03:45:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:45:16 INFO - 'RUST_BACKTRACE': 'full', 03:45:16 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:45:16 INFO - 'SHELL': '/bin/bash', 03:45:16 INFO - 'SHLVL': '1', 03:45:16 INFO - 'TERM': 'linux', 03:45:16 INFO - 'TMOUT': '86400', 03:45:16 INFO - 'USER': 'cltbld', 03:45:16 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1505556404.851400-389019985', 03:45:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:16 INFO - '_': '/tools/buildbot/bin/python'} 03:45:16 INFO - TEST-INFO | started process 10490 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCinOR8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:45:17 INFO - PID 10490 | 03:45:17 INFO - PID 10490 | (/builds/slave/test/build/application/firefox/firefox:10538): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:45:17 INFO - PID 10490 | 03:45:27 INFO - PID 10490 | RSS: Main: 154710016 03:45:27 INFO - PID 10490 | 03:45:30 INFO - PID 10490 | Cycle 1(1): loaded http://localhost:47931/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47931/tests/kraken/driver.html?testName=audio-beat-detection) 03:45:31 INFO - PID 10490 | RSS: Main: 160038912 03:45:31 INFO - PID 10490 | 03:45:34 INFO - PID 10490 | Cycle 1(1): loaded http://localhost:47931/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47931/tests/kraken/driver.html?testName=audio-dft) 03:45:34 INFO - PID 10490 | RSS: Main: 160612352 03:45:34 INFO - PID 10490 | 03:45:37 INFO - PID 10490 | Cycle 1(1): loaded http://localhost:47931/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47931/tests/kraken/driver.html?testName=audio-fft) 03:45:38 INFO - PID 10490 | RSS: Main: 156987392 03:45:38 INFO - PID 10490 | 03:45:40 INFO - PID 10490 | Cycle 1(1): loaded http://localhost:47931/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47931/tests/kraken/driver.html?testName=audio-oscillator) 03:45:40 INFO - PID 10490 | RSS: Main: 158224384 03:45:40 INFO - PID 10490 | 03:45:43 INFO - PID 10490 | Cycle 1(1): loaded http://localhost:47931/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47931/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:45:43 INFO - PID 10490 | RSS: Main: 157814784 03:45:43 INFO - PID 10490 | 03:45:46 INFO - PID 10490 | Cycle 1(1): loaded http://localhost:47931/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47931/tests/kraken/driver.html?testName=imaging-darkroom) 03:45:47 INFO - PID 10490 | RSS: Main: 161038336 03:45:47 INFO - PID 10490 | 03:45:51 INFO - PID 10490 | Cycle 1(1): loaded http://localhost:47931/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47931/tests/kraken/driver.html?testName=imaging-desaturate) 03:45:51 INFO - PID 10490 | RSS: Main: 160477184 03:45:51 INFO - PID 10490 | 03:45:54 INFO - PID 10490 | Cycle 1(1): loaded http://localhost:47931/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47931/tests/kraken/driver.html?testName=json-parse-financial) 03:45:55 INFO - PID 10490 | RSS: Main: 160235520 03:45:55 INFO - PID 10490 | 03:45:56 INFO - PID 10490 | Cycle 1(1): loaded http://localhost:47931/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47931/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:45:57 INFO - PID 10490 | RSS: Main: 160120832 03:45:57 INFO - PID 10490 | 03:45:59 INFO - PID 10490 | Cycle 1(1): loaded http://localhost:47931/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47931/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:45:59 INFO - PID 10490 | RSS: Main: 160137216 03:45:59 INFO - PID 10490 | 03:46:01 INFO - PID 10490 | Cycle 1(1): loaded http://localhost:47931/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47931/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:46:02 INFO - PID 10490 | RSS: Main: 157003776 03:46:02 INFO - PID 10490 | 03:46:05 INFO - PID 10490 | Cycle 1(1): loaded http://localhost:47931/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47931/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:46:05 INFO - PID 10490 | RSS: Main: 157184000 03:46:05 INFO - PID 10490 | 03:46:08 INFO - PID 10490 | Cycle 1(1): loaded http://localhost:47931/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47931/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:46:09 INFO - PID 10490 | RSS: Main: 157732864 03:46:09 INFO - PID 10490 | 03:46:11 INFO - PID 10490 | Cycle 1(1): loaded http://localhost:47931/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47931/tests/kraken/driver.html?testName=ai-astar) 03:46:11 INFO - PID 10490 | RSS: Main: 159014912 03:46:11 INFO - PID 10490 | 03:46:11 INFO - PID 10490 | __start_tp_report 03:46:11 INFO - PID 10490 | _x_x_mozilla_page_load 03:46:11 INFO - PID 10490 | _x_x_mozilla_page_load_details 03:46:11 INFO - PID 10490 | |i|pagename|runs| 03:46:11 INFO - PID 10490 | |0;ai-astar;108;109;109;106;106;111;109;107;107;108 03:46:11 INFO - PID 10490 | |1;audio-beat-detection;119;115;127;116;115;115;142;115;149;121 03:46:11 INFO - PID 10490 | |2;audio-dft;164;162;162;163;163;163;166;164;168;163 03:46:11 INFO - PID 10490 | |3;audio-fft;74;74;76;74;74;75;74;76;74;73 03:46:11 INFO - PID 10490 | |4;audio-oscillator;79;81;79;82;83;81;79;78;79;79 03:46:11 INFO - PID 10490 | |5;imaging-gaussian-blur;111;114;113;113;114;114;115;115;114;114 03:46:11 INFO - PID 10490 | |6;imaging-darkroom;150;148;147;150;147;149;148;147;149;150 03:46:11 INFO - PID 10490 | |7;imaging-desaturate;102;93;93;94;95;94;95;94;94;100 03:46:11 INFO - PID 10490 | |8;json-parse-financial;53;54;55;54;56;56;57;61;54;54 03:46:11 INFO - PID 10490 | |9;json-stringify-tinderbox;38;38;38;38;38;40;37;38;38;38 03:46:11 INFO - PID 10490 | |10;stanford-crypto-aes;75;74;75;76;75;75;78;75;79;74 03:46:11 INFO - PID 10490 | |11;stanford-crypto-ccm;114;114;110;113;113;113;113;122;111;129 03:46:11 INFO - PID 10490 | |12;stanford-crypto-pbkdf2;174;183;169;171;178;165;170;174;172;169 03:46:11 INFO - PID 10490 | |13;stanford-crypto-sha256-iterative;68;64;66;64;64;69;65;65;70;69 03:46:11 INFO - PID 10490 | __end_tp_report 03:46:11 INFO - PID 10490 | __start_cc_report 03:46:11 INFO - PID 10490 | _x_x_mozilla_cycle_collect,720 03:46:11 INFO - PID 10490 | __end_cc_report 03:46:11 INFO - PID 10490 | __startTimestamp1505558771346__endTimestamp 03:46:11 INFO - PID 10490 | 03:46:11 INFO - PID 10490 | ------- Summary: start ------- 03:46:11 INFO - PID 10490 | Number of tests: 14 03:46:11 INFO - PID 10490 | 03:46:11 INFO - PID 10490 | [#0] ai-astar Cycles:10 Average:108.00 Median:108.50 stddev:1.56 (1.4%) stddev-sans-first:1.66 03:46:11 INFO - PID 10490 | Values: 108.0 109.0 109.0 106.0 106.0 111.0 109.0 107.0 107.0 108.0 03:46:11 INFO - PID 10490 | 03:46:11 INFO - PID 10490 | [#1] audio-beat-detection Cycles:10 Average:123.40 Median:120.00 stddev:12.37 (10.3%) stddev-sans-first:13.01 03:46:11 INFO - PID 10490 | Values: 119.0 115.0 127.0 116.0 115.0 115.0 142.0 115.0 149.0 121.0 03:46:11 INFO - PID 10490 | 03:46:11 INFO - PID 10490 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.50 stddev:1.87 (1.1%) stddev-sans-first:1.99 03:46:11 INFO - PID 10490 | Values: 164.0 162.0 162.0 163.0 163.0 163.0 166.0 164.0 168.0 163.0 03:46:11 INFO - PID 10490 | 03:46:11 INFO - PID 10490 | [#3] audio-fft Cycles:10 Average:74.40 Median:74.00 stddev:0.97 (1.3%) stddev-sans-first:1.01 03:46:11 INFO - PID 10490 | Values: 74.0 74.0 76.0 74.0 74.0 75.0 74.0 76.0 74.0 73.0 03:46:11 INFO - PID 10490 | 03:46:11 INFO - PID 10490 | [#4] audio-oscillator Cycles:10 Average:80.00 Median:80.00 stddev:1.63 (2.0%) stddev-sans-first:1.69 03:46:11 INFO - PID 10490 | Values: 79.0 81.0 79.0 82.0 83.0 81.0 79.0 78.0 79.0 79.0 03:46:11 INFO - PID 10490 | 03:46:11 INFO - PID 10490 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:1.16 (1.0%) stddev-sans-first:0.71 03:46:11 INFO - PID 10490 | Values: 111.0 114.0 113.0 113.0 114.0 114.0 115.0 115.0 114.0 114.0 03:46:11 INFO - PID 10490 | 03:46:11 INFO - PID 10490 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:149.00 stddev:1.27 (0.9%) stddev-sans-first:1.22 03:46:11 INFO - PID 10490 | Values: 150.0 148.0 147.0 150.0 147.0 149.0 148.0 147.0 149.0 150.0 03:46:11 INFO - PID 10490 | 03:46:11 INFO - PID 10490 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:94.00 stddev:3.06 (3.3%) stddev-sans-first:2.12 03:46:11 INFO - PID 10490 | Values: 102.0 93.0 93.0 94.0 95.0 94.0 95.0 94.0 94.0 100.0 03:46:11 INFO - PID 10490 | 03:46:11 INFO - PID 10490 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.50 stddev:2.32 (4.2%) stddev-sans-first:2.29 03:46:11 INFO - PID 10490 | Values: 53.0 54.0 55.0 54.0 56.0 56.0 57.0 61.0 54.0 54.0 03:46:11 INFO - PID 10490 | 03:46:11 INFO - PID 10490 | [#9] json-stringify-tinderbox Cycles:10 Average:38.10 Median:38.00 stddev:0.74 (1.9%) stddev-sans-first:0.78 03:46:11 INFO - PID 10490 | Values: 38.0 38.0 38.0 38.0 38.0 40.0 37.0 38.0 38.0 38.0 03:46:11 INFO - PID 10490 | 03:46:11 INFO - PID 10490 | [#10] stanford-crypto-aes Cycles:10 Average:75.60 Median:75.00 stddev:1.65 (2.2%) stddev-sans-first:1.73 03:46:11 INFO - PID 10490 | Values: 75.0 74.0 75.0 76.0 75.0 75.0 78.0 75.0 79.0 74.0 03:46:11 INFO - PID 10490 | 03:46:11 INFO - PID 10490 | [#11] stanford-crypto-ccm Cycles:10 Average:115.20 Median:113.50 stddev:5.81 (5.1%) stddev-sans-first:6.14 03:46:11 INFO - PID 10490 | Values: 114.0 114.0 110.0 113.0 113.0 113.0 113.0 122.0 111.0 129.0 03:46:11 INFO - PID 10490 | 03:46:11 INFO - PID 10490 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.50 Median:173.00 stddev:5.10 (3.0%) stddev-sans-first:5.39 03:46:11 INFO - PID 10490 | Values: 174.0 183.0 169.0 171.0 178.0 165.0 170.0 174.0 172.0 169.0 03:46:11 INFO - PID 10490 | 03:46:11 INFO - PID 10490 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:67.00 stddev:2.37 (3.5%) stddev-sans-first:2.44 03:46:11 INFO - PID 10490 | Values: 68.0 64.0 66.0 64.0 64.0 69.0 65.0 65.0 70.0 69.0 03:46:11 INFO - PID 10490 | -------- Summary: end -------- 03:46:11 INFO - PID 10490 | 03:46:11 INFO - PID 10490 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:46:12 INFO - TEST-INFO | 10490: exit 0 03:46:12 INFO - TEST-OK | kraken | took 61402ms 03:46:12 INFO - SUITE-END | took 1170s 03:46:12 INFO - Completed test suite (00:19:30) 03:46:12 INFO - javascript benchmark 03:46:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8402.17292946305, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3060.34202646431, 3075.661677215507, 3102.860371283293, 3113.2061324362285, 3127.984360078199, 6064.211652485182, 6115.266168059828, 6120.571559990803, 6145.078238264263, 6197.380261973806, 6121.632702037881, 6184.474319682821, 6227.190465239512, 6239.220097487814, 6246.656433896134, 5623.437656234385, 5695.77216911323, 5700.3159620845345, 5701.572382071351, 5798.971005144989, 5776.508996735282, 5800.013997620415, 5803.883922321572, 5810.041343178371, 5829.417058294179, 5738.368779434259, 5785.768569257246, 5803.767849286023, 5811.128330750379, 5848.035074212771, 5566.4990150886615, 5633.8309850704545, 5705.058665320217, 5772.6536407815665, 5831.533477321804, 5652.208690783294, 5693.3452652945025, 5732.426757324234, 5738.110592858114, 5750.626209296424, 6127.785527506516, 6209.627422354673, 6224.533160012972, 6247.9687601562155, 6306.87386252277, 6446.548741588043, 6556.770513032068, 6570.704318305688, 6720.361565651256, 6722.83192920176, 6525.836854078686, 6761.121054262963, 6764.729410823561, 6767.255601883789, 6772.458203343721, 6033.909491357633, 6191.2570491540855, 6226.564140510166, 6249.812505624838, 6265.686715664244, 6789.355011273921, 6879.5184337096925, 6942.93057069433, 6957.721691132298, 6962.1645402551, 6365.172527571386, 6433.228012638513, 6495.285518592951, 6563.835904102436, 6646.102776125258, 6695.631740254333, 6708.228553716288, 6719.596824190564, 6724.7646332378135, 6760.256371799098, 6633.502487313374, 6645.966770166118, 6653.434458071021, 6718.832029199211, 6752.83117922046, 6500.122483464766, 6667.166604174478, 6673.899891501631, 6748.966255168692, 6758.05387245786, 5238.030964271622, 5238.7904483820985, 5239.0, 5242.213667949762, 5249.895002099936, 4550.953280745381, 4567.611753000966, 4574.862754117382, 4579.267317229227, 4584.220682483986, 5691.943080569225, 5734.311882574035, 5777.075667893117, 5804.88390232193, 5815.73829177688, 6649.434798042221, 6722.9663851680425, 6724.4284235840505, 6736.292689267556, 6748.291429399842, 5693.743781529758, 5696.914546281809, 5758.596898217168, 5764.827055188351, 5787.305523337226, 5639.351474580476, 5725.0, 5760.395158508296, 5797.88404231913, 5812.505936995318, 6459.515536334794, 6504.804855854332, 6506.1541999540705, 6536.803895883131, 6546.116274303004, 6663.766768163091, 6664.100346453264, 6747.493937954575, 6764.661766911537, 6778.356056174655, 6366.236051673829, 6404.871902562016, 6426.164598602339, 6449.064885591657, 6518.73925042993, 6611.338866113542, 6615.04081908111, 6615.206175258807, 6632.933670663425, 6674.833129171615, 6622.602643841385, 6704.094947182068, 6780.93219067803, 6790.83022924411, 6806.659667016728, 6417.7753778617525, 6452.451541618827, 6494.967525162344, 6503.869922601616, 6518.934810651833, 6335.588186767845, 6412.583182093149, 6431.292557818542, 6473.676316184078, 6487.156669632917, 6361.8727625448155, 6424.871502570016, 6431.839204019937, 6432.292447830641, 6484.513661475314, 6428.389303016206, 6540.542162048611, 6577.736890524326, 6594.076829244005, 6599.967000164968, 6116.5106791457465, 6285.0, 6365.395287447685, 6391.265004524539, 6397.96801015992], "value": 6075.381811963615, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [840.3907167303702, 851.7317045130783, 855.1533981358457, 858.8926384201975, 867.8067656971666, 39990.800045999764, 40803.0, 41253.381199282, 41260.0, 41328.79335603325, 37545.0, 37609.24781504375, 37717.245655086954, 37723.0, 37778.622213777926, 7013.544119632207, 7078.186008608998, 7082.150141982944, 7083.0, 7089.468289878254, 7041.753538626149, 7122.1453425589, 7140.32166944142, 7153.785386438415, 7165.283471652845, 7669.923300766976, 7831.138574756772, 7840.960795196016, 7868.724594639189, 7876.684932602689, 7764.456488045839, 7798.688052477894, 7829.921700782977, 7855.41084418668, 7874.960625196894, 7566.205548417447, 7630.236976302325, 7717.344025757818, 7747.496412733154, 7759.961200193963, 37152.44271335932, 37414.0, 37499.0, 37644.81177594094, 37683.62316376856, 3425.383430982422, 3459.377312083824, 3479.4085005548864, 3482.094655389617, 3501.77238479498, 30720.84639576788, 30778.53832192519, 30811.69188308133, 30834.0, 30869.845650771826, 5070.670406423571, 5188.533032027098, 5214.0, 5236.764345604419, 5344.385395679507, 179966.0, 180789.0, 181428.0, 181684.9999999987, 181734.0, 46604.0, 46898.53101468942, 46925.5307446928, 46925.82685432823, 46940.0, 48107.0, 48379.75810120927, 48661.5133848657, 48701.756491218024, 48900.755496223006, 15812.841871581368, 16105.597360066093, 16108.516744497683, 16114.597135071717, 16155.596110097342, 13231.536896208587, 13307.0, 13346.666333341744, 13363.0, 13364.866351336363, 13887.513937012358, 13956.09285396446, 13998.510052148125, 14025.71948561023, 14074.788878166835, 5860.472557469848, 5927.911081333697, 5951.702414879239, 5997.0, 6010.248718910137, 1011.4234886114843, 1013.2299452416216, 1014.7666036811427, 1018.5263852308564, 1040.2042437535292, 22590.532297067355, 22736.43158921007, 22870.313890583308, 22908.08367665308, 22932.541349172923, 1114.225613198819, 1119.1941801902617, 1121.6522877907876, 1128.1933417606288, 1131.6491887514896, 11850.288982661068, 11935.641930742091, 11959.222650527689, 11992.400379980965, 12039.0, 220047.0, 222458.0, 222569.0, 223050.0, 223155.0, 51812.74093629508, 52150.217746733826, 54232.72883635556, 55540.16689749657, 55925.7203713987, 1399.230423267199, 1430.8569143085608, 1443.6174413780357, 1447.7466443372368, 1453.2515754386711, 26390.340241494116, 26416.8679156603, 26787.33031674224, 26802.731972680023, 26937.191884243504, 36758.44862327014, 36793.816030919676, 36810.26379472342, 36885.0, 36914.0, 186235.0, 187210.0, 187679.0, 188446.0, 188707.0, 31965.68034319627, 32137.517937230492, 32181.839090804395, 32365.676343236268, 32550.0, 39565.0, 40560.0, 40874.38688419617, 40970.59029409787, 41125.588744112174, 30160.09519714412, 30529.54205686961, 30676.539851902686, 31040.223994399417, 31380.215494612818, 30119.849400752857, 30288.242793930327, 30387.848060759556, 31176.532352014285, 31345.52981705322, 32923.67076329206, 33978.660213398536, 34035.319293613495, 34052.31895362029, 34082.82958585191, 30214.54678179785, 30522.542161867146, 30528.694713053475, 31005.379892401575, 31544.36911261716, 21934.45163870916, 22037.11851525921, 22040.0, 22083.33749987503, 22171.556568868855], "value": 16818.95424886416, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.1632135475431, 563.8505795964073, 574.4686165297102, 578.6470253145582, 596.6181643748002, 21914.45213869654, 22481.55036899263, 22696.9786359614, 22727.977241024153, 22738.431539211528, 23523.882380588075, 24439.266821995323, 24519.50960980784, 24659.75340246597, 24816.255512334614, 6337.809865704036, 6563.245226798931, 6575.572587781779, 6581.506387020969, 6582.078509008718, 6429.260635026962, 6547.083408322838, 6547.181602299713, 6556.409923106919, 6565.80302590923, 6159.353267906872, 6420.486361091125, 6422.646754428504, 6426.518011149159, 6431.356864313578, 6350.936490635127, 6394.200724909387, 6395.104685344056, 6427.903581446282, 6448.065030570588, 5753.194552762617, 5917.763289468416, 6019.578629495937, 6031.1254868044325, 6041.033434650435, 27570.448591028267, 27954.580681289797, 27995.86002069997, 27999.440011199866, 28008.0, 1957.980420195794, 2001.9299324523718, 2002.5594369238745, 2004.7393838800863, 2009.4875806669352, 18905.527361815926, 19200.231990720353, 19506.512337191543, 19523.609527809505, 19558.217671293132, 2357.870317132557, 2416.5287768885073, 2420.9394765130837, 2448.0574978633176, 2468.148488771389, 128864.0, 134043.32978335142, 134071.0, 135903.0, 136512.31743841316, 14736.600022997798, 14847.480338188112, 14940.730037946896, 14999.250037498081, 15254.694906101815, 22519.437014074778, 22521.662175067388, 22563.88718056432, 22605.321840344815, 22607.321780346614, 10207.795844083077, 10209.489525523843, 10259.897401026043, 10347.63783267582, 10493.685189444328, 9532.378595886186, 9623.470709110927, 9672.70981870545, 9678.225741940629, 9715.417074975525, 8595.398322117391, 9023.458592484472, 9086.818263634823, 9136.725898223063, 9181.77045573866, 2434.3914021494625, 2466.4080620650916, 2500.0, 2500.2874180858366, 2622.0822712051013, 955.5031383680447, 961.1733908838394, 966.415318732157, 986.9834070906977, 988.8961659025842, 18417.723734143998, 18566.164522596246, 18661.81338186628, 18963.336283230296, 19072.427827165207, 1025.564135242519, 1037.227265687053, 1039.3036665434176, 1048.5111142178125, 1048.528162326956, 10108.191344692406, 10277.588896444207, 10402.27184097121, 10546.839847616757, 10561.63034293796, 446544.46965229505, 449247.0, 451325.0, 456814.0, 460800.0, 107496.46251768692, 108083.45958270159, 110104.4494777521, 110856.4457177709, 112061.43969280101, 1133.1161693878953, 1138.5407519757284, 1159.1016961854461, 1161.1929708852267, 1169.222467059413, 16584.253708582903, 16617.252223649724, 16642.0, 16708.16459177012, 16734.49796506107, 56567.71716141393, 57333.0, 58112.70943645255, 59257.70371148117, 60206.69896650489, 74666.62666686632, 74787.0, 75651.24348756662, 76157.61921190358, 76294.61852690922, 12819.294938778457, 13737.656558585715, 13949.442022318994, 13950.651233719238, 13964.511242106477, 21611.459713507287, 21883.562328753655, 21913.342599722033, 21967.780322196573, 22157.1137154512, 17410.564735881704, 17672.028038457494, 17729.11354432299, 17959.01225432614, 17973.37093201732, 15738.740900727686, 15935.20323983773, 16257.268422921234, 16283.430079947146, 16536.338546458006, 16763.329466821677, 17526.474205773848, 17542.21060052275, 17631.82368176353, 17659.55851103733, 13579.86420135786, 13783.173009619455, 13831.30843457803, 13852.238126903118, 13868.72262554723, 16825.41111061107, 16897.239624216694, 17007.659846803243, 17019.0, 17384.0], "value": 11658.739615590075, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1307.339793404331, 1362.8773410393067, 1366.8199222240523, 1366.8564800695926, 1382.1776043254267, 15034.77447838282, 15794.210289485538, 15794.36822527099, 15798.131102789328, 15812.367505299775, 15397.307121179545, 15504.534863954072, 15506.302216400261, 15533.456329028459, 15572.0, 2674.638923745289, 2686.1001564475873, 2740.328619488218, 2746.121241202816, 2750.601162831398, 2729.140320798942, 2759.103291430283, 2769.363046499306, 2771.7921155913386, 2778.3470884342164, 2608.373990242347, 2633.104744386908, 2749.6975332713387, 2750.106215479967, 2751.2159034675124, 2689.2201261634104, 2712.91861244163, 2736.904208352708, 2739.8767055482454, 2742.437800250944, 2557.9488410231693, 2634.6574945256993, 2655.137080448862, 2658.0, 2674.304680782991, 15354.846451535564, 15474.148921809408, 15505.534833955, 15532.223388830625, 15535.300911459011, 8056.476329038594, 8272.503649781032, 8340.582970851434, 8383.371247156487, 8390.32877369809, 5524.640898341595, 5624.903143886943, 5702.714864256771, 5750.482456578886, 5781.913271300934, 1908.4560900143392, 1928.9131989060527, 1940.5439721665398, 1950.3173889138689, 1970.448274483147, 26706.0, 26854.462910741677, 26899.0, 26944.46111077787, 26954.5956810648, 6672.933270667231, 6785.253622101565, 6831.180258368928, 6989.650517474106, 6994.475414343945, 17286.567835804206, 17287.481375558753, 17300.826991729922, 17308.221130049176, 17329.133543322783, 7836.804079897935, 7986.440949133621, 7990.360771138295, 7994.360451163893, 7997.040355157302, 7223.747168849065, 7356.190819009905, 7384.335409813142, 7474.5888976106835, 7493.887591686129, 4935.333729946483, 5077.543021128116, 5113.233015047773, 5142.202958541432, 5157.303763991813, 1527.923603819827, 1528.6866192430525, 1533.1031346662328, 1545.296889915086, 1564.2022568489924, 849.4987957105337, 862.491130233153, 883.3021912689032, 885.5306687455659, 889.1908363389284, 7315.122185337794, 8618.698345557876, 8776.297896168291, 8840.602172902234, 8853.69012084574, 630.1713247080075, 658.4896705053621, 659.9109120268798, 660.7819419591523, 664.3522565498697, 4763.499832517605, 5261.210818377198, 5307.734613269321, 5391.514763671288, 5439.972800135974, 21222.575548489254, 21820.672689909665, 22059.889700551714, 22218.222362217246, 22275.443113922283, 20670.58658826815, 21878.671819922714, 21881.234156804436, 22107.447313816963, 22189.556208876056, 10951.123910087334, 11078.778424431628, 11140.665780026613, 11148.944255278833, 11356.48895799691, 8307.127751585997, 8334.999800024036, 8363.665453381796, 8407.537585432616, 8535.914640853513, 18581.44255672332, 18862.0, 19000.809991899903, 19144.329948451737, 19267.710984334964, 19201.903990479957, 19352.225910963403, 19425.611487769882, 19439.12523936398, 19523.414297571097, 10957.726056848642, 11162.162837787037, 11170.776584468427, 11171.608993685182, 11185.32888026721, 13288.933555332162, 13317.33413329349, 13328.200307981551, 13348.132371396217, 13428.261445620585, 10777.515011824644, 10819.94421059996, 11113.499892504695, 11123.721906952067, 11311.0, 11064.0, 11081.501332439899, 11308.943455282671, 11402.144839136932, 11471.655850324503, 10125.139363154214, 10321.0, 10325.122364599094, 10335.22485813582, 10335.534900929326, 7383.667734952048, 7449.553026818191, 7451.3666338361845, 7519.774406767806, 7531.548107113591, 7349.375303099083, 7505.737299194502, 7556.773296801105, 7632.961835190788, 7702.5763583001235], "value": 6660.9039876878005, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [507.5564569986891, 512.6923845692583, 519.2756105233198, 521.449870386742, 536.6887205420855, 6290.119383286338, 6326.936730632692, 6329.746810127601, 6343.777967771129, 6373.426391624747, 6173.50611951044, 6233.875322493547, 6255.687215639223, 6258.311585725566, 6299.181106456166, 5194.454582268864, 5196.662216955895, 5220.477952204768, 5224.29472021278, 5227.0, 4781.37842080529, 4974.228994505839, 5200.167973124301, 5200.843974680765, 5225.503577160163, 4896.485868983741, 4941.77762000709, 4997.42529609096, 5007.724575148365, 5017.824376146836, 4917.655764096515, 4926.655134140611, 4960.355153830015, 4967.0, 4985.476524964899, 4422.15978963999, 4422.579854913778, 4446.42196514451, 4450.399196108517, 4453.220686379903, 6125.938740612626, 6166.907496387557, 6190.350013248589, 6197.16338294329, 6213.596116252429, 5661.886762264773, 5677.489025987681, 5680.4319568043275, 5713.542916566665, 5726.3700992890745, 6457.062881135687, 6458.967705161444, 6461.8061458156335, 6504.707288172043, 6521.478281737497, 4794.113089078532, 4819.228923372244, 4840.854774356775, 4863.294822250754, 4874.610031197496, 6615.569987950767, 6766.28953959837, 6797.6601169941305, 6889.3455121763855, 6930.896036559456, 4981.750912454435, 4986.509443389642, 5004.124278251292, 5013.37065453729, 5014.6991180529285, 5008.29883816266, 5054.4078615236085, 5071.619628527875, 5081.796728130834, 5093.465186155475, 5648.830535083954, 5682.40334764852, 5690.715464226772, 5702.0, 5711.7719690266795, 6622.337766223339, 6623.86752264952, 6625.436837868835, 6641.535092543476, 6644.66776661165, 1753.4038426934903, 1759.4369801663345, 1762.8325309095615, 1766.2493440287826, 1769.5841477252836, 1121.3216004317433, 1191.3090407563766, 1203.1638011581867, 1214.7509760499076, 1217.34263497712, 5663.377028526858, 5681.176229446707, 5706.857328566819, 5728.513076388554, 5740.7277851625, 6659.4006539411685, 6680.966595166993, 6690.264070952191, 6726.630035348005, 6760.864782704319, 5571.303587051619, 5635.6618602883955, 5646.407127251579, 5679.971600141973, 5700.572457065654, 3494.0475298372835, 3508.8947331580093, 3550.25444656625, 3553.9289214216087, 3559.4660800880074, 6386.840328991812, 6395.296517383084, 6400.359964003563, 6472.15861937945, 6510.381513756186, 6731.865362692816, 6763.0193621924545, 6850.040994260808, 6850.6574671266235, 6874.8625027500175, 6340.968295158495, 6396.42432181106, 6408.455281300955, 6417.1657684500715, 6430.80707578764, 6061.242344706911, 6572.211334639874, 6586.769463068769, 6616.536842420985, 6641.236257830411, 6451.741930322734, 6458.38645328693, 6541.0, 6633.2371777246235, 6648.16897887764, 6388.520860935356, 6399.776007839703, 6404.295527491879, 6415.71129299192, 6438.420542151229, 4881.804727810848, 4964.726940018189, 4978.8755281118265, 4989.925151122663, 5008.373953255843, 6495.707693153914, 6547.345265473415, 6674.364780628777, 6747.156605424322, 6785.59286442815, 6435.420812126931, 6441.323661015525, 6441.838954026187, 6450.258640078042, 6477.643729594917, 6543.149390579194, 6569.9343006571235, 6571.934280657132, 6583.3087525811015, 6592.208934927839, 6415.422611964946, 6437.613743175424, 6460.8707825842275, 6508.772192973223, 6517.502922983126, 6586.242582103119, 6607.636579988147, 6608.70260838273, 6609.239937407259, 6617.900731488935, 6313.873722525615, 6337.510684988932, 6354.618722876642, 6368.4586810121655, 6419.0], "value": 5043.007230572128, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [884.9690260840872, 900.1403659505173, 919.793046564523, 921.728090213387, 934.5934518484462, 19047.0, 19767.308144214956, 19905.303314384, 20001.899990500064, 20013.899930500327, 18082.63834723308, 18359.265629374844, 18405.44783656489, 18698.813011869875, 18801.623967520674, 935.7192842147363, 953.1231267234161, 954.6467806911453, 956.5552018311483, 960.6829746183778, 955.5843208204418, 964.6575465709677, 965.7923546437514, 970.3547141151126, 990.301837204769, 1059.4543809937888, 1061.5170097605571, 1064.8136576099191, 1066.9466526673675, 1070.2508244229032, 987.274353350287, 1057.6668349469892, 1061.851340812287, 1063.3194755356578, 1068.1668298727006, 734.0970606154407, 735.8270806360501, 739.7484855149221, 745.80981849628, 748.1620584944842, 18874.905625471783, 19021.239150433965, 19218.615627687366, 19324.613507729908, 19327.51681207967, 21889.562208755895, 22108.778912210833, 22668.659970100463, 22787.08851645932, 22825.657615135788, 16391.426300079558, 17010.0, 17032.82967170325, 17168.91415542927, 17174.22715977784, 3741.30785804627, 3795.6773674237725, 3800.562935262425, 3806.5812760596314, 3808.9428658570146, 145156.0, 145772.2711386447, 146326.0, 148362.0, 150682.24658876745, 16248.0, 16448.259828307517, 16473.34106635745, 16491.257893394824, 16522.917385413235, 26650.466990660465, 27068.729312707015, 27081.052163174194, 27138.321541961213, 27571.724282756917, 8580.227779499875, 8589.52757598338, 8606.31149508038, 8613.96632404103, 8638.17937295956, 3635.4365073413665, 3651.0, 3671.5227020487164, 3687.870924517629, 3703.166787472797, 5498.202760599691, 5531.529819965268, 5540.750666220029, 5587.8824235152315, 5606.243157173811, 972.8443449048118, 989.9604015839429, 1001.1990407673832, 1006.2805094357569, 1009.2279406254221, 700.684691888642, 706.3184027413571, 707.1125737199884, 716.2085895085959, 729.1214087025122, 10478.0, 10850.511726972305, 10954.452277386099, 11025.83461248082, 11099.72250693739, 697.7243988624465, 704.9013138160661, 717.9676914538858, 719.7660760252938, 722.7867779005206, 5181.35233095863, 5193.532582067632, 5322.680639161663, 5358.5981051421295, 5404.32445944257, 113169.0, 115540.42229788797, 118262.0, 118776.40611796886, 119775.0, 105343.0, 107325.0, 107924.0, 111262.44368778267, 112393.43803281095, 91161.54419227861, 92187.0, 95319.52340238393, 95324.0, 95810.0, 9789.97205293434, 9874.963128871364, 10053.04496072872, 10061.849072263776, 10159.796804064024, 45317.77341113273, 45385.54614453813, 46669.299960501296, 46748.29877551908, 46827.765861171836, 57754.422455776585, 58789.41210587839, 59197.0, 59610.0, 59869.101963471454, 15840.60398490047, 15874.761878572062, 15878.52364429069, 15906.920465398061, 16001.199940003185, 16715.164241788105, 16745.162741863103, 16832.915835420743, 16937.661246775242, 17066.232019559397, 15754.133522656364, 16141.0, 16181.029138251743, 16350.427735029218, 16378.344866205218, 15169.165695886832, 15421.383144674535, 15424.46014389491, 15499.457518987232, 15637.609059773597, 15130.470433534774, 15178.848211517743, 15262.236888155327, 15346.079235245921, 15566.37734490653, 11006.229563930448, 11031.779364412827, 11075.778484430106, 11418.086553075567, 11467.082633389477, 10737.0, 10787.244892857738, 10927.945360273467, 11138.498767555642, 11255.493502792559], "value": 8791.796442246949, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1430.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 109.0, 109.0, 106.0, 106.0, 111.0, 109.0, 107.0, 107.0, 108.0], "value": 108.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 115.0, 127.0, 116.0, 115.0, 115.0, 142.0, 115.0, 149.0, 121.0], "value": 123.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 162.0, 163.0, 163.0, 163.0, 166.0, 164.0, 168.0, 163.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 74.0, 74.0, 75.0, 74.0, 76.0, 74.0, 73.0], "value": 74.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 79.0, 82.0, 83.0, 81.0, 79.0, 78.0, 79.0, 79.0], "value": 80.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 113.0, 113.0, 114.0, 114.0, 115.0, 115.0, 114.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 148.0, 147.0, 150.0, 147.0, 149.0, 148.0, 147.0, 149.0, 150.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 93.0, 93.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 100.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 55.0, 54.0, 56.0, 56.0, 57.0, 61.0, 54.0, 54.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 38.0, 40.0, 37.0, 38.0, 38.0, 38.0], "value": 38.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 76.0, 75.0, 75.0, 78.0, 75.0, 79.0, 74.0], "value": 75.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 110.0, 113.0, 113.0, 113.0, 113.0, 122.0, 111.0, 129.0], "value": 115.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 183.0, 169.0, 171.0, 178.0, 165.0, 170.0, 174.0, 172.0, 169.0], "value": 172.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 64.0, 66.0, 64.0, 64.0, 69.0, 65.0, 65.0, 70.0, 69.0], "value": 66.4, "unit": "score"}]}]} 03:46:12 INFO - Return code: 0 03:46:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:46:12 INFO - # TBPL SUCCESS # 03:46:12 INFO - Running post-action listener: _package_coverage_data 03:46:12 INFO - Running post-action listener: _resource_record_post_action 03:46:12 INFO - [mozharness: 2017-09-16 10:46:12.638981Z] Finished run-tests step (success) 03:46:12 INFO - Running post-run listener: _resource_record_post_run 03:46:12 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 20480; Write bytes: 420356096; Read time: 324; Write time: 254912 03:46:12 INFO - TinderboxPrint: CPU usage
13.1% 03:46:12 INFO - TinderboxPrint: I/O read bytes / time
20,480 / 324 03:46:12 INFO - TinderboxPrint: I/O write bytes / time
420,356,096 / 254,912 03:46:12 INFO - TinderboxPrint: CPU idle
8,236.8 (86.9%) 03:46:12 INFO - TinderboxPrint: CPU user
1,192.6 (12.6%) 03:46:12 INFO - TinderboxPrint: Swap in / out
0 / 0 03:46:12 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 12288; Write bytes: 91496448; Read time: 148; Write time: 58608 03:46:12 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:46:12 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 328859648; Read time: 160; Write time: 196304 03:46:13 INFO - Running post-run listener: _upload_blobber_files 03:46:13 INFO - Blob upload gear active. 03:46:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:46:13 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:46:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:46:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:46:13 INFO - (blobuploader) - INFO - Open directory for files ... 03:46:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:46:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:14 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:46:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:14 INFO - (blobuploader) - INFO - Done attempting. 03:46:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:46:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:46:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:15 INFO - (blobuploader) - INFO - Done attempting. 03:46:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:46:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:46:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:22 INFO - (blobuploader) - INFO - Done attempting. 03:46:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:46:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:46:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:23 INFO - (blobuploader) - INFO - Done attempting. 03:46:23 INFO - (blobuploader) - INFO - Iteration through files over. 03:46:23 INFO - Return code: 0 03:46:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:46:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:46:23 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0345f38b9b97036f306908d89746cfad6ff1bf7b9dcd09c5ce0c1d3bc498240b003836dc1fba5c948dd9119178bb50fc808f73a4e7e0117a386054a33140804a", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a5a2ab7e65f13459d6e9f311961235c9c889c405f18dffea165cd8d551903f5640a185908558434606718651310b916b851e5cd2668d6bbb74007aa014c8a2bf", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a09ed409890b914deb040ef16b463617b395dfdafac6b65ce7f15543847c685c6cdfae0702f7dfde3fa58b22c14bbc4ed464a4005c82a86375385fc07f1b069f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c8be1f924a9951da34c4942b30c962d93a89f8be1ecb6ca18c4ed07e53f8bfee4cb37a34261cfcf6e3e183119b1eded05b3ee7162f8db09953aa8a45923fcb70"} 03:46:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:46:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:46:23 INFO - Contents: 03:46:23 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0345f38b9b97036f306908d89746cfad6ff1bf7b9dcd09c5ce0c1d3bc498240b003836dc1fba5c948dd9119178bb50fc808f73a4e7e0117a386054a33140804a", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a5a2ab7e65f13459d6e9f311961235c9c889c405f18dffea165cd8d551903f5640a185908558434606718651310b916b851e5cd2668d6bbb74007aa014c8a2bf", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a09ed409890b914deb040ef16b463617b395dfdafac6b65ce7f15543847c685c6cdfae0702f7dfde3fa58b22c14bbc4ed464a4005c82a86375385fc07f1b069f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c8be1f924a9951da34c4942b30c962d93a89f8be1ecb6ca18c4ed07e53f8bfee4cb37a34261cfcf6e3e183119b1eded05b3ee7162f8db09953aa8a45923fcb70"} 03:46:23 INFO - Running post-run listener: copy_logs_to_upload_dir 03:46:23 INFO - Copying logs to upload dir... 03:46:23 INFO - mkdir: /builds/slave/test/build/upload/logs 03:46:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.488675 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-16 03:46:23.352516) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 03:46:23.356084) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1505556404.851400-389019985 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/0345f38b9b97036f306908d89746cfad6ff1bf7b9dcd09c5ce0c1d3bc498240b003836dc1fba5c948dd9119178bb50fc808f73a4e7e0117a386054a33140804a", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a5a2ab7e65f13459d6e9f311961235c9c889c405f18dffea165cd8d551903f5640a185908558434606718651310b916b851e5cd2668d6bbb74007aa014c8a2bf", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a09ed409890b914deb040ef16b463617b395dfdafac6b65ce7f15543847c685c6cdfae0702f7dfde3fa58b22c14bbc4ed464a4005c82a86375385fc07f1b069f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c8be1f924a9951da34c4942b30c962d93a89f8be1ecb6ca18c4ed07e53f8bfee4cb37a34261cfcf6e3e183119b1eded05b3ee7162f8db09953aa8a45923fcb70"} build_url:https://queue.taskcluster.net/v1/task/QKXeurjvQniffQGOJwEu5g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011379 build_url: 'https://queue.taskcluster.net/v1/task/QKXeurjvQniffQGOJwEu5g/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0345f38b9b97036f306908d89746cfad6ff1bf7b9dcd09c5ce0c1d3bc498240b003836dc1fba5c948dd9119178bb50fc808f73a4e7e0117a386054a33140804a", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a5a2ab7e65f13459d6e9f311961235c9c889c405f18dffea165cd8d551903f5640a185908558434606718651310b916b851e5cd2668d6bbb74007aa014c8a2bf", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a09ed409890b914deb040ef16b463617b395dfdafac6b65ce7f15543847c685c6cdfae0702f7dfde3fa58b22c14bbc4ed464a4005c82a86375385fc07f1b069f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c8be1f924a9951da34c4942b30c962d93a89f8be1ecb6ca18c4ed07e53f8bfee4cb37a34261cfcf6e3e183119b1eded05b3ee7162f8db09953aa8a45923fcb70"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 03:46:23.384565) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:46:23.384924) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1505556404.851400-389019985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004579 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:46:23.470637) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 03:46:23.470950) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 03:46:23.471309) ========= ========= Total master_lag: 0.20 =========