builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-012 starttime: 1503267450.66 results: success (0) revision: 7dddbd85047c6dc73ddbe1e423cd643a217845b3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-20 15:17:30.660807) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-20 15:17:30.661195) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-20 15:17:30.661479) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-20 15:17:30.715675) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 15:17:30.715962) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1503266609.579673-355119672 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-20 15:17: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% 224M=0s 2017-08-20 15:17:31 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.134644 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 15:17:30.865941) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 15:17:30.866214) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1503266609.579673-355119672 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016875 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 15:17:30.914839) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 12 secs) (at 2017-08-20 15:17:30.915142) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7dddbd85047c6dc73ddbe1e423cd643a217845b3 --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 7dddbd85047c6dc73ddbe1e423cd643a217845b3 --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=2c5dd2b0a310ecf02fd87158000001b4-1503266609.579673-355119672 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-20 15:17:31,214 truncating revision to first 12 chars 2017-08-20 15:17:31,214 Setting DEBUG logging. 2017-08-20 15:17:31,214 attempt 1/10 2017-08-20 15:17:31,214 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7dddbd85047c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-20 15:17:32,219 attempt 1/10 2017-08-20 15:17:32,893 current task status: no status available at this point. state: STARTED 2017-08-20 15:17:32,894 sleeping for 10.00s (attempt 1/10) 2017-08-20 15:17:42,904 attempt 2/10 2017-08-20 15:17:43,230 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-08-20 15:17:43,441 unpacking tar archive at: mozilla-central-7dddbd85047c/testing/mozharness/ program finished with exit code 0 elapsedTime=12.579384 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 12 secs) (at 2017-08-20 15:17:43.511172) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-20 15:17:43.514474) ========= script_repo_revision: 7dddbd85047c6dc73ddbe1e423cd643a217845b3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-20 15:17:43.514859) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-20 15:17:43.515121) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-20 15:17:43.526974) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-08-20 15:17:43.527236) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=2c5dd2b0a310ecf02fd87158000001b4-1503266609.579673-355119672 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:17:43 INFO - MultiFileLogger online at 20170820 15:17:43 in /builds/slave/test 15:17:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 15:17:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:17:43 INFO - {'append_to_log': False, 15:17:43 INFO - 'base_work_dir': '/builds/slave/test', 15:17:43 INFO - 'blob_upload_branch': 'Firefox', 15:17:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:17:43 INFO - 'branch': 'Firefox', 15:17:43 INFO - 'buildbot_json_path': 'buildprops.json', 15:17:43 INFO - 'code_coverage': False, 15:17:43 INFO - 'config_files': ('talos/linux_config.py',), 15:17:43 INFO - 'default_actions': ('clobber', 15:17:43 INFO - 'read-buildbot-config', 15:17:43 INFO - 'download-and-extract', 15:17:43 INFO - 'populate-webroot', 15:17:43 INFO - 'create-virtualenv', 15:17:43 INFO - 'install', 15:17:43 INFO - 'setup-mitmproxy', 15:17:43 INFO - 'run-tests'), 15:17:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:17:43 INFO - 'disable_ccov_upload': False, 15:17:43 INFO - 'download_minidump_stackwalk': True, 15:17:43 INFO - 'download_symbols': 'ondemand', 15:17:43 INFO - 'enable_stylo': False, 15:17:43 INFO - 'enable_webrender': False, 15:17:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:17:43 INFO - 'tooltool.py': '/tools/tooltool.py', 15:17:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:17:43 INFO - '/tools/misc-python/virtualenv.py')}, 15:17:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:17:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:17:43 INFO - 'gecko_profile': False, 15:17:43 INFO - 'gecko_profile_interval': 0, 15:17:43 INFO - 'installer_path': 'installer.exe', 15:17:43 INFO - 'log_level': 'info', 15:17:43 INFO - 'log_name': 'talos', 15:17:43 INFO - 'log_to_console': True, 15:17:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:17:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:17:43 INFO - 'opt_config_files': (), 15:17:43 INFO - 'pip_index': False, 15:17:43 INFO - 'suite': 'dromaeojs-e10s', 15:17:43 INFO - 'system_bits': '32', 15:17:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:17:43 INFO - 'title': 'talos-linux64-ix-012', 15:17:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:17:43 INFO - 'use_talos_json': True, 15:17:43 INFO - 'verify': 'False', 15:17:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:17:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:17:43 INFO - 'work_dir': 'build'} 15:17:43 INFO - [mozharness: 2017-08-20 22:17:43.966105Z] Running clobber step. 15:17:43 INFO - Running pre-action listener: _resource_record_pre_action 15:17:43 INFO - Running main action method: clobber 15:17:43 INFO - rmtree: /builds/slave/test/build 15:17:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:17:44 INFO - Running post-action listener: _resource_record_post_action 15:17:44 INFO - [mozharness: 2017-08-20 22:17:44.991278Z] Finished clobber step (success) 15:17:44 INFO - [mozharness: 2017-08-20 22:17:44.991375Z] Running read-buildbot-config step. 15:17:44 INFO - Running pre-action listener: _resource_record_pre_action 15:17:44 INFO - Running main action method: read_buildbot_config 15:17:44 INFO - Using buildbot properties: 15:17:44 INFO - { 15:17:44 INFO - "project": "", 15:17:44 INFO - "product": "firefox", 15:17:44 INFO - "who": "archaeopteryx@coole-files.de", 15:17:44 INFO - "installer_path": "public/build/target.tar.bz2", 15:17:44 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 15:17:44 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:17:44 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 15:17:44 INFO - "stage_platform": "linux64-qr", 15:17:44 INFO - "basedir": "/builds/slave/test", 15:17:44 INFO - "buildnumber": 11, 15:17:44 INFO - "platform": "ubuntu64_hw_qr", 15:17:44 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:17:44 INFO - "slavebuilddir": "test", 15:17:44 INFO - "taskId": "aQdKh_LIQYCKP7Hyu9dbkg", 15:17:44 INFO - "branch": "mozilla-central", 15:17:44 INFO - "script_repo_revision": "production", 15:17:44 INFO - "revision": "7dddbd85047c6dc73ddbe1e423cd643a217845b3", 15:17:44 INFO - "slavename": "talos-linux64-ix-012", 15:17:44 INFO - "repo_path": "mozilla-central" 15:17:44 INFO - } 15:17:44 INFO - Finding installer, test and symbols from parent task. 15:17:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aQdKh_LIQYCKP7Hyu9dbkg'}, attempt #1 15:17:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aQdKh_LIQYCKP7Hyu9dbkg'}, attempt #1 15:17:45 INFO - Task dependencies: W2sfHt0TS8KDAxRbisPdNA 15:17:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA'}, attempt #1 15:17:46 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.tar.bz2 15:17:46 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.test_packages.json 15:17:46 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.crashreporter-symbols.zip 15:17:46 INFO - Running post-action listener: _resource_record_post_action 15:17:46 INFO - [mozharness: 2017-08-20 22:17:46.345512Z] Finished read-buildbot-config step (success) 15:17:46 INFO - [mozharness: 2017-08-20 22:17:46.345727Z] Running download-and-extract step. 15:17:46 INFO - Running pre-action listener: _resource_record_pre_action 15:17:46 INFO - Running main action method: download_and_extract 15:17:46 INFO - mkdir: /builds/slave/test/build/tests 15:17: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')]} 15:17:46 INFO - trying https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.test_packages.json 15:17:46 INFO - Downloading https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:17:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:17:46 INFO - Downloaded 989 bytes. 15:17:46 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:17:46 INFO - Using the following test package requirements: 15:17:46 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:17:46 INFO - u'common': [u'target.common.tests.zip'], 15:17:46 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:17:46 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:17:46 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:17:46 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:17:46 INFO - u'mozbase': [u'target.common.tests.zip'], 15:17:46 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:17:46 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:17:46 INFO - u'web-platform': [u'target.common.tests.zip', 15:17:46 INFO - u'target.web-platform.tests.tar.gz'], 15:17:46 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:17:46 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 15:17:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.common.tests.zip 15:17:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:17:46 INFO - Fetch https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.common.tests.zip into memory 15:17:48 INFO - Content-Length response header: 54005757 15:17:48 INFO - Bytes received: 54005757 15:17:59 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 15:17:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.common.tests.zip 15:17:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:17:59 INFO - Fetch https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.common.tests.zip into memory 15:18:00 INFO - Content-Length response header: 54005757 15:18:00 INFO - Bytes received: 54005757 15:18:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.talos.tests.zip 15:18:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:18:12 INFO - Fetch https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.talos.tests.zip into memory 15:18:13 INFO - Content-Length response header: 14496256 15:18:13 INFO - Bytes received: 14496256 15:18:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:18:13 INFO - trying https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.tar.bz2 15:18:13 INFO - Downloading https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:18:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:18:15 INFO - Downloaded 62126211 bytes. 15:18:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.tar.bz2 15:18:15 INFO - mkdir: /builds/slave/test/properties 15:18:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:18:15 INFO - Writing to file /builds/slave/test/properties/build_url 15:18:15 INFO - Contents: 15:18:15 INFO - build_url:https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.tar.bz2 15:18:15 INFO - Running post-action listener: _resource_record_post_action 15:18:15 INFO - Running post-action listener: find_tests_for_verification 15:18:15 INFO - Running post-action listener: set_extra_try_arguments 15:18:15 INFO - [mozharness: 2017-08-20 22:18:15.653510Z] Finished download-and-extract step (success) 15:18:15 INFO - [mozharness: 2017-08-20 22:18:15.653606Z] Running populate-webroot step. 15:18:15 INFO - Running pre-action listener: _resource_record_pre_action 15:18:15 INFO - Running main action method: populate_webroot 15:18:15 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:18:15 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 15:18:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:18:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:18:15 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 15:18:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:18:15 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:18:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:18:15 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:18:15 INFO - 'talos_options': ['--stylo'], 15:18:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:18:15 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:18:15 INFO - 'tests': ['damp', 'tps']}, 15:18:15 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:18:15 INFO - 'talos_options': ['--stylo'], 15:18:15 INFO - 'tests': ['damp', 'tps']}, 15:18:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:18:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:18:15 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 15:18:15 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 15:18:15 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:18:15 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:18:15 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:18:15 INFO - 'talos_options': ['--stylo'], 15:18:15 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:18:15 INFO - 'other-e10s': {'tests': ['a11yr', 15:18:15 INFO - 'ts_paint', 15:18:15 INFO - 'tpaint', 15:18:15 INFO - 'sessionrestore', 15:18:15 INFO - 'sessionrestore_many_windows', 15:18:15 INFO - 'sessionrestore_no_auto_restore', 15:18:15 INFO - 'tabpaint']}, 15:18:15 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 15:18:15 INFO - 'tests': ['a11yr', 15:18:15 INFO - 'ts_paint', 15:18:15 INFO - 'tpaint', 15:18:15 INFO - 'sessionrestore', 15:18:15 INFO - 'sessionrestore_many_windows', 15:18:15 INFO - 'sessionrestore_no_auto_restore', 15:18:15 INFO - 'tabpaint']}, 15:18:15 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:18:15 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 15:18:15 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 15:18:15 INFO - 'tests': ['bloom_basic_singleton']}, 15:18:15 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 15:18:15 INFO - 'tests': ['bloom_basic']}, 15:18:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:18:15 INFO - 'tsvgr_opacity', 15:18:15 INFO - 'tart', 15:18:15 INFO - 'tscrollx', 15:18:15 INFO - 'tsvg_static']}, 15:18:15 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 15:18:15 INFO - 'tests': ['tsvgx', 15:18:15 INFO - 'tsvgr_opacity', 15:18:15 INFO - 'tart', 15:18:15 INFO - 'tscrollx', 15:18:15 INFO - 'tsvg_static']}, 15:18:15 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:18:15 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:18:15 INFO - 'talos_options': ['--stylo'], 15:18:15 INFO - 'tests': ['tp5o']}, 15:18:15 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:18:15 INFO - 'talos_options': ['--mitmproxy', 15:18:15 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:18:15 INFO - '--firstNonBlankPaint'], 15:18:15 INFO - 'tests': ['tp6_google', 15:18:15 INFO - 'tp6_youtube', 15:18:15 INFO - 'tp6_amazon', 15:18:15 INFO - 'tp6_facebook']}, 15:18:15 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:18:15 INFO - 'talos_options': ['--stylo', 15:18:15 INFO - '--mitmproxy', 15:18:15 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:18:15 INFO - '--firstNonBlankPaint'], 15:18:15 INFO - 'tests': ['tp6_google', 15:18:15 INFO - 'tp6_youtube', 15:18:15 INFO - 'tp6_amazon', 15:18:15 INFO - 'tp6_facebook']}, 15:18:15 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:18:15 INFO - 'talos_options': ['--stylo', 15:18:15 INFO - '--stylo-threads=1', 15:18:15 INFO - '--mitmproxy', 15:18:15 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:18:15 INFO - '--firstNonBlankPaint'], 15:18:15 INFO - 'tests': ['tp6_google', 15:18:15 INFO - 'tp6_youtube', 15:18:15 INFO - 'tp6_amazon', 15:18:15 INFO - 'tp6_facebook']}, 15:18:15 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:18:15 INFO - 'talos_options': ['--xperf_path', 15:18:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:18:15 INFO - 'tests': ['tp5n']}, 15:18:15 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:18:15 INFO - 'talos_options': ['--stylo', 15:18:15 INFO - '--xperf_path', 15:18:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:18:15 INFO - 'tests': ['tp5n']}}} 15:18:15 INFO - Running post-action listener: _resource_record_post_action 15:18:15 INFO - [mozharness: 2017-08-20 22:18:15.667720Z] Finished populate-webroot step (success) 15:18:15 INFO - [mozharness: 2017-08-20 22:18:15.667809Z] Running create-virtualenv step. 15:18:15 INFO - Running pre-action listener: _resource_record_pre_action 15:18:15 INFO - Running main action method: create_virtualenv 15:18:15 INFO - Creating virtualenv /builds/slave/test/build/venv 15:18:15 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:18:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:18:15 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:18:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:18:15 INFO - Using real prefix '/usr' 15:18:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:18:16 INFO - Installing distribute.............................................................................................................................................................................................done. 15:18:18 INFO - Installing pip.................done. 15:18:18 INFO - Return code: 0 15:18:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:18:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:18:18 INFO - Reading from file tmpfile_stdout 15:18:18 INFO - Output received: 15:18:18 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 15:18:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:18:18 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')]} 15:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:18 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')]} 15:18:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:18 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 0x19401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caef90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cac130>, '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 0x1cad030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cad4c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1503266609.579673-355119672', '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 15:18:18 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 15:18:18 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 15:18:18 INFO - Using env: {'DISPLAY': ':0', 15:18:18 INFO - 'HOME': '/home/cltbld', 15:18:18 INFO - 'LANG': 'en_US.UTF-8', 15:18:18 INFO - 'LANGUAGE': 'en_US:en', 15:18:18 INFO - 'LOGNAME': 'cltbld', 15:18:18 INFO - 'MAIL': '/var/mail/cltbld', 15:18:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:18 INFO - 'MOZ_NO_REMOTE': '1', 15:18:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:18 INFO - 'NO_EM_RESTART': '1', 15:18:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:18 INFO - 'PWD': '/builds/slave/test', 15:18:18 INFO - 'SHELL': '/bin/bash', 15:18:18 INFO - 'SHLVL': '1', 15:18:18 INFO - 'TERM': 'linux', 15:18:18 INFO - 'TMOUT': '86400', 15:18:18 INFO - 'USER': 'cltbld', 15:18:18 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1503266609.579673-355119672', 15:18:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:18 INFO - '_': '/tools/buildbot/bin/python'} 15:18:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:18 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:18:18 INFO - Cleaning up... 15:18:18 INFO - Return code: 0 15:18:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:18:18 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')]} 15:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:18 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')]} 15:18:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:18 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 0x19401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caef90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cac130>, '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 0x1cad030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cad4c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1503266609.579673-355119672', '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 15:18:18 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 15:18:18 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 15:18:18 INFO - Using env: {'DISPLAY': ':0', 15:18:18 INFO - 'HOME': '/home/cltbld', 15:18:18 INFO - 'LANG': 'en_US.UTF-8', 15:18:18 INFO - 'LANGUAGE': 'en_US:en', 15:18:18 INFO - 'LOGNAME': 'cltbld', 15:18:18 INFO - 'MAIL': '/var/mail/cltbld', 15:18:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:18 INFO - 'MOZ_NO_REMOTE': '1', 15:18:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:18 INFO - 'NO_EM_RESTART': '1', 15:18:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:18 INFO - 'PWD': '/builds/slave/test', 15:18:18 INFO - 'SHELL': '/bin/bash', 15:18:18 INFO - 'SHLVL': '1', 15:18:18 INFO - 'TERM': 'linux', 15:18:18 INFO - 'TMOUT': '86400', 15:18:18 INFO - 'USER': 'cltbld', 15:18:18 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1503266609.579673-355119672', 15:18:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:18 INFO - '_': '/tools/buildbot/bin/python'} 15:18:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:18 INFO - Downloading/unpacking psutil>=3.1.1 15:18: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 15:18: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 15:18: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 15:18: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 15:18:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:18:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:18:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:18:20 INFO - Installing collected packages: psutil 15:18:20 INFO - Running setup.py install for psutil 15:18:20 INFO - building 'psutil._psutil_linux' extension 15:18:20 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 15:18:20 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 15:18:20 INFO - building 'psutil._psutil_posix' extension 15:18:20 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 15:18:20 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 15:18:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:18:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:18:20 INFO - Successfully installed psutil 15:18:20 INFO - Cleaning up... 15:18:20 INFO - Return code: 0 15:18:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:18: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')]} 15:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18: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')]} 15:18:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caef90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cac130>, '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 0x1cad030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cad4c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1503266609.579673-355119672', '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 15:18:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:18:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:18:20 INFO - Using env: {'DISPLAY': ':0', 15:18:20 INFO - 'HOME': '/home/cltbld', 15:18:20 INFO - 'LANG': 'en_US.UTF-8', 15:18:20 INFO - 'LANGUAGE': 'en_US:en', 15:18:20 INFO - 'LOGNAME': 'cltbld', 15:18:20 INFO - 'MAIL': '/var/mail/cltbld', 15:18:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:20 INFO - 'MOZ_NO_REMOTE': '1', 15:18:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:20 INFO - 'NO_EM_RESTART': '1', 15:18:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:20 INFO - 'PWD': '/builds/slave/test', 15:18:20 INFO - 'SHELL': '/bin/bash', 15:18:20 INFO - 'SHLVL': '1', 15:18:20 INFO - 'TERM': 'linux', 15:18:20 INFO - 'TMOUT': '86400', 15:18:20 INFO - 'USER': 'cltbld', 15:18:20 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1503266609.579673-355119672', 15:18:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:20 INFO - '_': '/tools/buildbot/bin/python'} 15:18:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:18: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 15:18: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 15:18: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 15:18: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 15:18:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:18:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:18:21 INFO - Installing collected packages: mozsystemmonitor 15:18:21 INFO - Running setup.py install for mozsystemmonitor 15:18:22 INFO - Successfully installed mozsystemmonitor 15:18:22 INFO - Cleaning up... 15:18:22 INFO - Return code: 0 15:18:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:18: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')]} 15:18:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18: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')]} 15:18:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caef90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cac130>, '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 0x1cad030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cad4c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1503266609.579673-355119672', '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 15:18: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==2.5.1'] in /builds/slave/test/build 15:18: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==2.5.1 15:18:22 INFO - Using env: {'DISPLAY': ':0', 15:18:22 INFO - 'HOME': '/home/cltbld', 15:18:22 INFO - 'LANG': 'en_US.UTF-8', 15:18:22 INFO - 'LANGUAGE': 'en_US:en', 15:18:22 INFO - 'LOGNAME': 'cltbld', 15:18:22 INFO - 'MAIL': '/var/mail/cltbld', 15:18:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:22 INFO - 'MOZ_NO_REMOTE': '1', 15:18:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:22 INFO - 'NO_EM_RESTART': '1', 15:18:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:22 INFO - 'PWD': '/builds/slave/test', 15:18:22 INFO - 'SHELL': '/bin/bash', 15:18:22 INFO - 'SHLVL': '1', 15:18:22 INFO - 'TERM': 'linux', 15:18:22 INFO - 'TMOUT': '86400', 15:18:22 INFO - 'USER': 'cltbld', 15:18:22 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1503266609.579673-355119672', 15:18:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:22 INFO - '_': '/tools/buildbot/bin/python'} 15:18:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:22 INFO - Downloading/unpacking jsonschema==2.5.1 15:18:22 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 15:18:22 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 15:18:22 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 15:18:22 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 15:18:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:18:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:18:23 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 15:18:23 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 15:18:23 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 15:18:23 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 15:18:23 INFO - Downloading functools32-3.2.3-2.tar.gz 15:18:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:18:23 INFO - warning: no files found matching '*.txt' 15:18:23 INFO - no previously-included directories found matching 'build' 15:18:23 INFO - no previously-included directories found matching 'dist' 15:18:23 INFO - no previously-included directories found matching '.git*' 15:18:23 INFO - Installing collected packages: jsonschema, functools32 15:18:23 INFO - Running setup.py install for functools32 15:18:23 INFO - warning: no files found matching '*.txt' 15:18:23 INFO - no previously-included directories found matching 'build' 15:18:23 INFO - no previously-included directories found matching 'dist' 15:18:23 INFO - no previously-included directories found matching '.git*' 15:18:23 INFO - Successfully installed jsonschema functools32 15:18:23 INFO - Cleaning up... 15:18:23 INFO - Return code: 0 15:18:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:18:23 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')]} 15:18:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:23 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')]} 15:18:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:23 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 0x19401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caef90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cac130>, '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 0x1cad030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cad4c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1503266609.579673-355119672', '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 15:18:23 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 15:18:23 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 15:18:23 INFO - Using env: {'DISPLAY': ':0', 15:18:23 INFO - 'HOME': '/home/cltbld', 15:18:23 INFO - 'LANG': 'en_US.UTF-8', 15:18:23 INFO - 'LANGUAGE': 'en_US:en', 15:18:23 INFO - 'LOGNAME': 'cltbld', 15:18:23 INFO - 'MAIL': '/var/mail/cltbld', 15:18:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:23 INFO - 'MOZ_NO_REMOTE': '1', 15:18:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:23 INFO - 'NO_EM_RESTART': '1', 15:18:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:23 INFO - 'PWD': '/builds/slave/test', 15:18:23 INFO - 'SHELL': '/bin/bash', 15:18:23 INFO - 'SHLVL': '1', 15:18:23 INFO - 'TERM': 'linux', 15:18:23 INFO - 'TMOUT': '86400', 15:18:23 INFO - 'USER': 'cltbld', 15:18:23 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1503266609.579673-355119672', 15:18:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:23 INFO - '_': '/tools/buildbot/bin/python'} 15:18:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:18:24 INFO - Cleaning up... 15:18:24 INFO - Return code: 0 15:18:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:18:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:18:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:24 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 0x19401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caef90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cac130>, '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 0x1cad030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cad4c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1503266609.579673-355119672', '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 15:18:24 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 15:18:24 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 15:18:24 INFO - Using env: {'DISPLAY': ':0', 15:18:24 INFO - 'HOME': '/home/cltbld', 15:18:24 INFO - 'LANG': 'en_US.UTF-8', 15:18:24 INFO - 'LANGUAGE': 'en_US:en', 15:18:24 INFO - 'LOGNAME': 'cltbld', 15:18:24 INFO - 'MAIL': '/var/mail/cltbld', 15:18:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:24 INFO - 'MOZ_NO_REMOTE': '1', 15:18:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:24 INFO - 'NO_EM_RESTART': '1', 15:18:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:24 INFO - 'PWD': '/builds/slave/test', 15:18:24 INFO - 'SHELL': '/bin/bash', 15:18:24 INFO - 'SHLVL': '1', 15:18:24 INFO - 'TERM': 'linux', 15:18:24 INFO - 'TMOUT': '86400', 15:18:24 INFO - 'USER': 'cltbld', 15:18:24 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1503266609.579673-355119672', 15:18:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:24 INFO - '_': '/tools/buildbot/bin/python'} 15:18:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:24 INFO - Downloading/unpacking blobuploader==1.2.4 15:18:24 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 15:18:24 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 15:18:24 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 15:18:24 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 15:18:25 INFO - Downloading blobuploader-1.2.4.tar.gz 15:18:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:18:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:18:25 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 15:18:25 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 15:18:25 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 15:18:25 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 15:18:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:18:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:18:25 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 15:18:25 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 15:18:25 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 15:18:25 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 15:18:25 INFO - Downloading docopt-0.6.1.tar.gz 15:18:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:18:25 INFO - Installing collected packages: blobuploader, requests, docopt 15:18:25 INFO - Running setup.py install for blobuploader 15:18:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:18:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:18:26 INFO - Running setup.py install for requests 15:18:26 INFO - Running setup.py install for docopt 15:18:26 INFO - Successfully installed blobuploader requests docopt 15:18:26 INFO - Cleaning up... 15:18:26 INFO - Return code: 0 15:18:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:18:26 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')]} 15:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:26 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')]} 15:18:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:26 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 0x19401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caef90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cac130>, '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 0x1cad030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cad4c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1503266609.579673-355119672', '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 15:18:26 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 15:18:26 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 15:18:26 INFO - Using env: {'DISPLAY': ':0', 15:18:26 INFO - 'HOME': '/home/cltbld', 15:18:26 INFO - 'LANG': 'en_US.UTF-8', 15:18:26 INFO - 'LANGUAGE': 'en_US:en', 15:18:26 INFO - 'LOGNAME': 'cltbld', 15:18:26 INFO - 'MAIL': '/var/mail/cltbld', 15:18:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:26 INFO - 'MOZ_NO_REMOTE': '1', 15:18:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:26 INFO - 'NO_EM_RESTART': '1', 15:18:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:26 INFO - 'PWD': '/builds/slave/test', 15:18:26 INFO - 'SHELL': '/bin/bash', 15:18:26 INFO - 'SHLVL': '1', 15:18:26 INFO - 'TERM': 'linux', 15:18:26 INFO - 'TMOUT': '86400', 15:18:26 INFO - 'USER': 'cltbld', 15:18:26 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1503266609.579673-355119672', 15:18:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:26 INFO - '_': '/tools/buildbot/bin/python'} 15:18:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:18:26 INFO - Running setup.py (path:/tmp/pip-BnawkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:18:26 INFO - Running setup.py (path:/tmp/pip-e9ji4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:18:26 INFO - Running setup.py (path:/tmp/pip-PMkEnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:18:26 INFO - Running setup.py (path:/tmp/pip-E7sGdQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:18:27 INFO - Running setup.py (path:/tmp/pip-Y70aK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:18:27 INFO - Running setup.py (path:/tmp/pip-SoUlzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:18:27 INFO - Running setup.py (path:/tmp/pip-9V669a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:18:27 INFO - Running setup.py (path:/tmp/pip-edQfzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:18:27 INFO - Running setup.py (path:/tmp/pip-gGw3ww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:18:27 INFO - Running setup.py (path:/tmp/pip-htbXXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:18:27 INFO - Running setup.py (path:/tmp/pip-9d4ISx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:18:27 INFO - Running setup.py (path:/tmp/pip-jK2WCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:18:27 INFO - Running setup.py (path:/tmp/pip-BqrifZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:18:27 INFO - Running setup.py (path:/tmp/pip-lPETyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:18:27 INFO - Running setup.py (path:/tmp/pip-BELlsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:18:27 INFO - Running setup.py (path:/tmp/pip-Zsjcfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:18:27 INFO - Running setup.py (path:/tmp/pip-mFUChf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:18:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:18:27 INFO - Running setup.py install for manifestparser 15:18:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:18:28 INFO - Running setup.py install for mozcrash 15:18:28 INFO - Running setup.py install for mozdebug 15:18:28 INFO - Running setup.py install for mozdevice 15:18:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:18:28 INFO - Running setup.py install for mozfile 15:18:28 INFO - Running setup.py install for mozhttpd 15:18:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:18:28 INFO - Running setup.py install for mozinfo 15:18:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:18:28 INFO - Running setup.py install for mozInstall 15:18:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:18:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:18:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:18:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:18:28 INFO - Running setup.py install for mozleak 15:18:28 INFO - Running setup.py install for mozlog 15:18:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:18:29 INFO - Running setup.py install for moznetwork 15:18:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:18:29 INFO - Running setup.py install for mozprocess 15:18:29 INFO - Running setup.py install for mozprofile 15:18:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:18:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:18:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:18:29 INFO - Running setup.py install for mozrunner 15:18:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:18:29 INFO - Running setup.py install for mozscreenshot 15:18:29 INFO - Running setup.py install for moztest 15:18:29 INFO - Running setup.py install for mozversion 15:18:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:18:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:18:29 INFO - Cleaning up... 15:18:29 INFO - Return code: 0 15:18:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:18:29 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')]} 15:18:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:29 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')]} 15:18:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:29 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 0x19401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caef90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cac130>, '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 0x1cad030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cad4c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1503266609.579673-355119672', '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 15:18:29 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 15:18:29 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 15:18:29 INFO - Using env: {'DISPLAY': ':0', 15:18:29 INFO - 'HOME': '/home/cltbld', 15:18:29 INFO - 'LANG': 'en_US.UTF-8', 15:18:29 INFO - 'LANGUAGE': 'en_US:en', 15:18:29 INFO - 'LOGNAME': 'cltbld', 15:18:29 INFO - 'MAIL': '/var/mail/cltbld', 15:18:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:29 INFO - 'MOZ_NO_REMOTE': '1', 15:18:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:29 INFO - 'NO_EM_RESTART': '1', 15:18:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:29 INFO - 'PWD': '/builds/slave/test', 15:18:29 INFO - 'SHELL': '/bin/bash', 15:18:29 INFO - 'SHLVL': '1', 15:18:29 INFO - 'TERM': 'linux', 15:18:29 INFO - 'TMOUT': '86400', 15:18:29 INFO - 'USER': 'cltbld', 15:18:29 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1503266609.579673-355119672', 15:18:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:29 INFO - '_': '/tools/buildbot/bin/python'} 15:18:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:18:29 INFO - Running setup.py (path:/tmp/pip-JOYRwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:18:30 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)) 15:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:18:30 INFO - Running setup.py (path:/tmp/pip-6ts8Qa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:18:30 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)) 15:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:18:30 INFO - Running setup.py (path:/tmp/pip-jciI5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:18:30 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)) 15:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:18:30 INFO - Running setup.py (path:/tmp/pip-lfX0X8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:18:30 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)) 15:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:18:30 INFO - Running setup.py (path:/tmp/pip-ZpUovt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:18:30 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)) 15:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:18:30 INFO - Running setup.py (path:/tmp/pip-YpPJ6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:18:30 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)) 15:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:18:30 INFO - Running setup.py (path:/tmp/pip-Y7XVTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:18:30 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)) 15:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:18:30 INFO - Running setup.py (path:/tmp/pip-4ac4D2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:18:30 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)) 15:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:18:30 INFO - Running setup.py (path:/tmp/pip-ff6bxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:18:30 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)) 15:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:18:30 INFO - Running setup.py (path:/tmp/pip-Q0xpSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:18:30 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)) 15:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:18:30 INFO - Running setup.py (path:/tmp/pip-16tokJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:18:30 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)) 15:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:18:30 INFO - Running setup.py (path:/tmp/pip-w6Uazt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:18:30 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)) 15:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:18:30 INFO - Running setup.py (path:/tmp/pip-cqWN7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:18:30 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)) 15:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:18:30 INFO - Running setup.py (path:/tmp/pip-ySsZk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:18:31 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)) 15:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:18:31 INFO - Running setup.py (path:/tmp/pip-tlWyXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:18:31 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)) 15:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:18:31 INFO - Running setup.py (path:/tmp/pip-IoWoRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:18:31 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)) 15:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:18:31 INFO - Running setup.py (path:/tmp/pip-MBeNzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:18:31 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)) 15:18:31 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)) 15:18:31 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)) 15:18:31 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)) 15:18:31 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)) 15:18:31 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)) 15:18:31 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)) 15:18:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:18:31 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 15:18:31 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 15:18:31 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 15:18:31 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 15:18:32 INFO - Downloading blessings-1.6.tar.gz 15:18:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:18:32 INFO - Installing collected packages: blessings 15:18:32 INFO - Running setup.py install for blessings 15:18:32 INFO - Successfully installed blessings 15:18:32 INFO - Cleaning up... 15:18:32 INFO - Return code: 0 15:18:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:18:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:18:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:18:32 INFO - Reading from file tmpfile_stdout 15:18:32 INFO - Current package versions: 15:18:32 INFO - argparse == 1.2.1 15:18:32 INFO - blessings == 1.6 15:18:32 INFO - blobuploader == 1.2.4 15:18:32 INFO - docopt == 0.6.1 15:18:32 INFO - functools32 == 3.2.3-2 15:18:32 INFO - jsonschema == 2.5.1 15:18:32 INFO - manifestparser == 1.1 15:18:32 INFO - mozInstall == 1.13 15:18:32 INFO - mozcrash == 1.0 15:18:32 INFO - mozdebug == 0.1 15:18:32 INFO - mozdevice == 0.51 15:18:32 INFO - mozfile == 1.2 15:18:32 INFO - mozhttpd == 0.7 15:18:32 INFO - mozinfo == 0.10 15:18:32 INFO - mozleak == 0.1 15:18:32 INFO - mozlog == 3.5 15:18:32 INFO - moznetwork == 0.27 15:18:32 INFO - mozprocess == 0.25 15:18:32 INFO - mozprofile == 0.28 15:18:32 INFO - mozrunner == 6.13 15:18:32 INFO - mozscreenshot == 0.1 15:18:32 INFO - mozsystemmonitor == 0.3 15:18:32 INFO - moztest == 0.8 15:18:32 INFO - mozversion == 1.4 15:18:32 INFO - psutil == 3.1.1 15:18:32 INFO - requests == 1.2.3 15:18:32 INFO - wsgiref == 0.1.2 15:18:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:18:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:18:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:32 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 0x19401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caef90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cac130>, '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 0x1cad030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cad4c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1503266609.579673-355119672', '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 15:18:32 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 15:18:32 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 15:18:32 INFO - Using env: {'DISPLAY': ':0', 15:18:32 INFO - 'HOME': '/home/cltbld', 15:18:32 INFO - 'LANG': 'en_US.UTF-8', 15:18:32 INFO - 'LANGUAGE': 'en_US:en', 15:18:32 INFO - 'LOGNAME': 'cltbld', 15:18:32 INFO - 'MAIL': '/var/mail/cltbld', 15:18:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:32 INFO - 'MOZ_NO_REMOTE': '1', 15:18:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:32 INFO - 'NO_EM_RESTART': '1', 15:18:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:32 INFO - 'PWD': '/builds/slave/test', 15:18:32 INFO - 'SHELL': '/bin/bash', 15:18:32 INFO - 'SHLVL': '1', 15:18:32 INFO - 'TERM': 'linux', 15:18:32 INFO - 'TMOUT': '86400', 15:18:32 INFO - 'USER': 'cltbld', 15:18:32 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1503266609.579673-355119672', 15:18:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:32 INFO - '_': '/tools/buildbot/bin/python'} 15:18:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:32 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)) 15:18:32 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)) 15:18:32 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)) 15:18:32 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)) 15:18:32 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)) 15:18:32 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)) 15:18:32 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)) 15:18:32 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)) 15:18:32 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)) 15:18:32 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:18:32 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 15:18:32 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 15:18:32 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 15:18:32 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 15:18:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:18:34 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)) 15:18:34 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)) 15:18:34 INFO - Installing collected packages: simplejson 15:18:34 INFO - Running setup.py install for simplejson 15:18:34 INFO - building 'simplejson._speedups' extension 15:18:34 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 15:18:35 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 15:18:35 INFO - Successfully installed simplejson 15:18:35 INFO - Cleaning up... 15:18:35 INFO - Return code: 0 15:18:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:18:35 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')]} 15:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:35 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')]} 15:18:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:35 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 0x19401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caef90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cac130>, '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 0x1cad030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cad4c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1503266609.579673-355119672', '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 15:18:35 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 15:18:35 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 15:18:35 INFO - Using env: {'DISPLAY': ':0', 15:18:35 INFO - 'HOME': '/home/cltbld', 15:18:35 INFO - 'LANG': 'en_US.UTF-8', 15:18:35 INFO - 'LANGUAGE': 'en_US:en', 15:18:35 INFO - 'LOGNAME': 'cltbld', 15:18:35 INFO - 'MAIL': '/var/mail/cltbld', 15:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:35 INFO - 'MOZ_NO_REMOTE': '1', 15:18:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:35 INFO - 'NO_EM_RESTART': '1', 15:18:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:35 INFO - 'PWD': '/builds/slave/test', 15:18:35 INFO - 'SHELL': '/bin/bash', 15:18:35 INFO - 'SHLVL': '1', 15:18:35 INFO - 'TERM': 'linux', 15:18:35 INFO - 'TMOUT': '86400', 15:18:35 INFO - 'USER': 'cltbld', 15:18:35 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1503266609.579673-355119672', 15:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:35 INFO - '_': '/tools/buildbot/bin/python'} 15:18:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:18:35 INFO - Cleaning up... 15:18:35 INFO - Return code: 0 15:18:35 INFO - Running post-action listener: _resource_record_post_action 15:18:35 INFO - Running post-action listener: _start_resource_monitoring 15:18:35 INFO - Starting resource monitoring. 15:18:35 INFO - [mozharness: 2017-08-20 22:18:35.493565Z] Finished create-virtualenv step (success) 15:18:35 INFO - [mozharness: 2017-08-20 22:18:35.494039Z] Running install step. 15:18:35 INFO - Running pre-action listener: _resource_record_pre_action 15:18:35 INFO - Running main action method: install 15:18:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:18:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:18:35 INFO - Reading from file tmpfile_stdout 15:18:35 INFO - Detecting whether we're running mozinstall >=1.0... 15:18:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:18:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:18:35 INFO - Reading from file tmpfile_stdout 15:18:35 INFO - Output received: 15:18:35 INFO - Usage: mozinstall [options] installer 15:18:35 INFO - Options: 15:18:35 INFO - -h, --help show this help message and exit 15:18:35 INFO - -d DEST, --destination=DEST 15:18:35 INFO - Directory to install application into. [default: 15:18:35 INFO - "/builds/slave/test"] 15:18:35 INFO - --app=APP Application being installed. [default: firefox] 15:18:35 INFO - mkdir: /builds/slave/test/build/application 15:18:35 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'] 15:18:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:18:53 INFO - Reading from file tmpfile_stdout 15:18:53 INFO - Output received: 15:18:53 INFO - /builds/slave/test/build/application/firefox/firefox 15:18:53 INFO - Running post-action listener: _resource_record_post_action 15:18:53 INFO - [mozharness: 2017-08-20 22:18:53.789536Z] Finished install step (success) 15:18:53 INFO - [mozharness: 2017-08-20 22:18:53.789818Z] Running setup-mitmproxy step. 15:18:53 INFO - Running pre-action listener: _resource_record_pre_action 15:18:53 INFO - Running main action method: setup_mitmproxy 15:18:53 INFO - Skipping: mitmproxy is not required 15:18:53 INFO - Running post-action listener: _resource_record_post_action 15:18:53 INFO - [mozharness: 2017-08-20 22:18:53.790953Z] Finished setup-mitmproxy step (success) 15:18:53 INFO - [mozharness: 2017-08-20 22:18:53.791169Z] Running run-tests step. 15:18:53 INFO - Running pre-action listener: _resource_record_pre_action 15:18:53 INFO - Running pre-action listener: _set_gcov_prefix 15:18:53 INFO - Running main action method: run_tests 15:18:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:18:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:18:53 INFO - Python 2.7.3 15:18:53 INFO - Return code: 0 15:18:53 INFO - grabbing minidump binary from tooltool 15:18:53 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')]} 15:18:53 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 0x1cac130>, '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 0x1cad030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cad4c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:18:53 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 15:18:53 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:18:53 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 15:18:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:18:53 INFO - Return code: 0 15:18:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:18:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:18:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:18:53 INFO - ENV: RUST_BACKTRACE is now full 15:18:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:18:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:18:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 15:18:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 15:18:53 INFO - Using env: {'DISPLAY': ':0', 15:18:53 INFO - 'HOME': '/home/cltbld', 15:18:53 INFO - 'LANG': 'en_US.UTF-8', 15:18:53 INFO - 'LANGUAGE': 'en_US:en', 15:18:53 INFO - 'LOGNAME': 'cltbld', 15:18:53 INFO - 'MAIL': '/var/mail/cltbld', 15:18:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:18:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:18:53 INFO - 'MOZ_ACCELERATED': '1', 15:18:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:53 INFO - 'MOZ_NO_REMOTE': '1', 15:18:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:18:53 INFO - 'MOZ_WEBRENDER': '1', 15:18:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:53 INFO - 'NO_EM_RESTART': '1', 15:18:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:53 INFO - 'PWD': '/builds/slave/test', 15:18:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:18:53 INFO - 'RUST_BACKTRACE': 'full', 15:18:53 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:18:53 INFO - 'SHELL': '/bin/bash', 15:18:53 INFO - 'SHLVL': '1', 15:18:53 INFO - 'TERM': 'linux', 15:18:53 INFO - 'TMOUT': '86400', 15:18:53 INFO - 'USER': 'cltbld', 15:18:53 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1503266609.579673-355119672', 15:18:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:53 INFO - '_': '/tools/buildbot/bin/python'} 15:18:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 15:18:54 INFO - mozversion application_buildid: 20170820212432 15:18:54 INFO - mozversion application_changeset: 7dddbd85047c6dc73ddbe1e423cd643a217845b3 15:18:54 INFO - mozversion application_display_name: Nightly 15:18:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:18:54 INFO - mozversion application_name: Firefox 15:18:54 INFO - mozversion application_remotingname: firefox 15:18:54 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:18:54 INFO - mozversion application_vendor: Mozilla 15:18:54 INFO - mozversion application_version: 57.0a1 15:18:54 INFO - mozversion platform_buildid: 20170820212432 15:18:54 INFO - mozversion platform_changeset: 7dddbd85047c6dc73ddbe1e423cd643a217845b3 15:18:54 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:18:54 INFO - mozversion platform_version: 57.0a1 15:18:54 INFO - using testdate: 1503267534 15:18:54 INFO - actual date: 1503267534 15:18:54 INFO - starting webserver on 'localhost:55837' 15:18:54 INFO - SUITE-START | Running 2 tests 15:18:54 INFO - TEST-START | dromaeo_css 15:18:54 INFO - Initialising browser for dromaeo_css test... 15:18:54 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55837/getInfo.html -profile /tmp/tmpoJZlrk/profile 15:18:54 INFO - TEST-INFO | started process 15012 (/builds/slave/test/build/application/firefox/firefox http://localhost:55837/getInfo.html) 15:18:59 INFO - TEST-INFO | 15012: exit 0 15:19:00 INFO - Browser initialized. 15:19:00 INFO - Running cycle 1/1 for dromaeo_css test... 15:19:00 INFO - TEST-INFO | started process 15196 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoJZlrk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:19:00 INFO - PID 15196 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 15:19:01 INFO - PID 15196 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 15:19:01 INFO - PID 15196 | 15:19:01 INFO - PID 15196 | (/builds/slave/test/build/application/firefox/firefox:15255): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:19:01 INFO - PID 15196 | 15:19:02 INFO - PID 15196 | 15:19:02 INFO - PID 15196 | (/builds/slave/test/build/application/firefox/firefox:15311): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:19:02 INFO - PID 15196 | 15:19:02 INFO - PID 15196 | __metrics Screen width/height:1600/1200 15:19:02 INFO - PID 15196 | colorDepth:24 15:19:02 INFO - PID 15196 | Browser inner width/height: 1024/768 15:19:02 INFO - PID 15196 | __metrics 15:19:11 INFO - PID 15196 | RSS: Main: 198262784 15:19:11 INFO - PID 15196 | 15:19:15 INFO - PID 15196 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 15:22:11 INFO - PID 15196 | Cycle 1(1): loaded http://localhost:55837/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55837/tests/dromaeo/cssquery-ext.html) 15:22:12 INFO - PID 15196 | RSS: Main: 209166336 15:22:12 INFO - PID 15196 | 15:25:15 INFO - PID 15196 | Cycle 1(1): loaded http://localhost:55837/tests/dromaeo/cssquery-ext.html (next: http://localhost:55837/tests/dromaeo/cssquery-jquery.html) 15:25:15 INFO - PID 15196 | RSS: Main: 209620992 15:25:15 INFO - PID 15196 | 15:28:17 INFO - PID 15196 | Cycle 1(1): loaded http://localhost:55837/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55837/tests/dromaeo/cssquery-mootools.html) 15:28:18 INFO - PID 15196 | RSS: Main: 209268736 15:28:18 INFO - PID 15196 | 15:31:20 INFO - PID 15196 | Cycle 1(1): loaded http://localhost:55837/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55837/tests/dromaeo/cssquery-prototype.html) 15:31:21 INFO - PID 15196 | RSS: Main: 207073280 15:31:21 INFO - PID 15196 | 15:34:25 INFO - PID 15196 | Cycle 1(1): loaded http://localhost:55837/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55837/tests/dromaeo/cssquery-yui.html) 15:34:26 INFO - PID 15196 | RSS: Main: 211062784 15:34:26 INFO - PID 15196 | 15:37:28 INFO - PID 15196 | Cycle 1(1): loaded http://localhost:55837/tests/dromaeo/cssquery-yui.html (next: http://localhost:55837/tests/dromaeo/cssquery-dojo.html) 15:37:28 INFO - PID 15196 | RSS: Main: 210403328 15:37:28 INFO - PID 15196 | 15:37:28 INFO - PID 15196 | __start_tp_report 15:37:28 INFO - PID 15196 | _x_x_mozilla_page_load 15:37:28 INFO - PID 15196 | _x_x_mozilla_page_load_details 15:37:28 INFO - PID 15196 | |i|pagename|runs| 15:37:28 INFO - PID 15196 | |0;dojo.html;3125.8124512529243;3150.149459645897;3169.587953566036;3170.3976244513556;3178.4755515339957;6049.818505444844;6135.263768347799;6153.9076913846275;6216.191895053642;6241.188645476093;6120.571559990803;6121.571489995702;6123.357047510014;6161.568690191689;6179.7837075702355;5600.4959553640165;5650.74571644276;5663.150527420899;5667.574931880125;5733.684647344395;5655.462731040565;5667.489925906668;5684.602077854552;5702.429757024306;5738.885222295552;5627.846291510231;5643.125315576092;5678.659280443166;5722.7424765885635;5759.740811663464;5599.020171469997;5644.520215781664;5702.657840529581;5710.428957104277;5743.8564035899435;5480.862978425532;5544.750486228089;5552.7223638817895;5554.750036248379;5683.2895888014;6055.364186760371;6089.177960975256;6122.448979591813;6139.754409823602;6162.7226774795245;6512.381323774234;6570.408663220333;6614.900776488356;6714.227863795629;6717.731290748364;6595.10966019586;6601.537892347537;6703.564268322592;6755.49333799967;6761;6189.81430557084;6192.690365481708;6221.564490485668;6236.282827474854;6252.3122456529745;6862.622555759481;6899.6205208713;6912.343327383991;6913.2049814270995;6923.757668481579;6469.159009328757;6530.314316996742;6608.768693095719;6612.437942774822;6615.636140012345;6597.1423714916755;6602.372774586406;6628.8674226515195;6715.026321183401;6734.696938637773;6511.120998665215;6590.637514936724;6612.86774264512;6656.500762442836;6695.732170713214;6677.465802735769;6688.230853451818;6698.4641228701585;6700.095487109178;6702.329767023356;5357.8392648220615;5397.2443857859935;5398.568114550826;5406.83779486616;5415.918761218585;4530.932036019462;4595.839145629954;4608.147492713859;4609.953900460952;4632.397788287569;5535.335759708861;5633.690147041952;5653.66078035311;5717.771289148471;5761.740721667535;6707.262201157869;6707.832304192337;6709;6710.228323742832;6719.025741267489;5606.383297837235;5778.162166485836;5778.971105144447;5817.331006934172;5821.592488525847;5928.081147422156;5929.05135178378;5932.911006334908;5933.703314834327;5933.970330148408;6402.295747467775;6408.679566021773;6453.146589935521;6495.805125846232;6499.8700025999215;6495.837604059936;6588.40704336612;6645.435138013323;6753.864922701617;6759.729610815709;6294.748210071546;6393.488520918222;6491.026346048131;6509.121268628674;6524.771632992823;6643.933560664332;6649.833754155991;6652.733890644514;6664.266930637723;6672.132622759011;6691;6700.698468569024;6781.321867813179;6784.728610855511;6785.762498312535;6478.449331806661;6509.902351464826;6514.3811337922825;6572.441342485751;6597.703103360456;6370.235571731422;6458;6460.612363258219;6556.082148499309;6584.934150658623;6437.452816510649;6444.420002199637;6458.54790164684;6516.348365163635;6520.217573891164;6550.082988381535;6568.901466477911;6598.241202261609;6630.701618427086;6637.502187336066;6284.717187726472;6365.61806291624;6423.96788016057;6448.097266382804;6457.838554036187 15:37:28 INFO - PID 15196 | |1;ext.html;785.7249962513117;848.8217474330391;868.0494858130347;868.5396739727946;1165.8309545115965;29093.418131637354;29896.701032989662;38963.41554876679;39831.60168398315;39909.40135897964;39894.401583976265;40005.199896002065;40312;40391.39412908801;40398;7605.277498637634;7724.652390642406;7743.728969486069;7762.611869406535;7764.495307805003;7107.147142342926;7260.927390726104;7726.575038372887;7737.806554836146;7756.883646745303;7654.655540500691;7660.540367577935;7668.233176682315;7738.961305193466;7740.729074482394;7618.085829700416;7622.771316860503;7689.307962283366;7697.307242348215;7726.7681969541;7565.167831538582;7637.885431718529;7646.502977306457;7698;7717.768466946;36135.63864361349;36158.27683446316;36177.457338139946;36294.45558316627;36460.81769591162;3495.353359628477;3498.667626575497;3515.859365625372;3532.0993146747674;3551.520544726455;29650.406991860258;29653.258668533243;29676.851615741998;29864.253393665116;29923.551146732818;5007.37407824022;5031.245313203012;5059.797608095671;5108.846734597968;5109.386873575158;189831;190464;190655;190831.9999999986;191098;46561.767191163824;46707;46808.53191468042;47112.7644361776;47155.52844471511;48949.75525122351;49277.507224928006;52142.47857521452;52746;52807.207891881655;14984.325705343286;15079.321430535652;15206.923965380101;15306.540803775904;15326.770098448533;12097.939510302569;12241.326727030098;12327.75344493123;12414.255144691348;12430.37848107591;14103.929480352532;14190.85809141916;14237.85762142386;14309.284535773379;14355.56933292003;5671.347795003628;5719.885602287931;5749.540036797046;5810.4770570648;5848.181254624356;986.8026394720941;992.7964767222846;1009.7374682582434;1011.7217765114652;1013.7972405518926;22373.664395034088;22816.885915570318;22926;23020.65469017966;23429.648555271684;1091.1870656361061;1102.4377567440504;1115.1134847795859;1119.1885882734953;1123.185690374472;11766.88233117675;12012.159148859497;12115.575954841539;12195.146339756131;12246.510139594495;228607;228915;229274;229358;231452;50028.49971500311;50648;50667.74666126646;50692.49307506951;50870.49129508658;1419.8864090872705;1459.5986103821533;1461.956141315741;1472.2197235465221;1481.8814494840603;22173.22393716212;22224.88887555552;22253.666195006765;22478.438039049153;22792.31623051311;35472.29055418826;35591.46612800758;35638.287234254654;35792.28415431625;35879.28241435209;189725;190186;190645;190913;192130;29390.706092938795;29391.265218368855;29485.85257073701;29625.5556166662;32422.189445264055;41564.37653435261;41657;41702.79148604238;42068.36897446479;42455.36316955186;30986.225344366572;31272.21819454441;31547.52678709867;31745.365092698477;32178.83910580432;30585.694143058285;30870.53694194544;30895.536566951963;31011.224719382197;31269.687303127586;32775.50836737498;33109.17227069342;33204;33274.00177994664;33711.83144084362;30417.847910760305;31049.44752762398;32494.187645309055;32624;32698.509522356708;24275.878620606785;24349.391265217804;24376.6343504844;24654.383640409134;24800.50398991974 15:37:28 INFO - PID 15196 | |2;jquery.html;537.2559005777;544.4201924949931;563.2508763344752;567.5913342393477;574.2993547871597;21541;22500;22574.887125564368;22578.661320080213;22617.321480355575;24543.754562454415;27158.18525444235;27171.86414067927;27371.726282737167;27397.726022739767;6201;6315.74737010519;6335.841603959915;6338.33447488014;6352.396522330371;6276.215473065867;6400.4559612432995;6417.101605775195;6417.39034791694;6424.678766061702;4128.855490057848;4154.4183814266025;5423.2136340230645;6362.45919096875;6895.482838787111;6855.485838562103;6878.965605171992;6880.587164770105;6891.724331026753;6904.723811047552;6790.253072162058;6808.5914845109455;6839.350261725128;6844.486663500207;6868.690908909061;30864.53703194454;31350;31479.953803002732;32439;32440.513392299134;1941.883486990785;2002.4793553676004;2005.0476023888682;2006.2677122850055;2025.878447293167;19824.504387390432;20546.486337841674;20553.38339849792;20589.4852628684;20689.482762930897;2419.806415486757;2447.5716749568933;2469.2839076667747;2513.296277042431;2567.8074144439242;133531.33234333864;138676;138854;139338;140499.29750351285;19504.31356904215;20823.271185508736;20899.68650470244;21821.345359639236;22396.55206895853;43944.78027609841;44187.55812441899;44374.00633942961;44387.55612443899;44418.11163776771;10914.454277286104;11026.944865275782;11091;11091.22361434708;11137.164712646583;9032.36773425867;9057.592408341641;9145.725628231165;9252.814943701089;9321.067893210624;8602.440841345293;9244.583993720298;9468.337216394786;10815.621453249098;11637.301761894314;2614.8494662348508;2624.619529963567;2704.107644477318;2734.9042783502878;2766.5573508238585;926.416357694648;957.4351132831663;959.1559427703576;965.8406362950175;988.3081842710131;20221.393358198984;20275.898620507098;20304.898475507824;20733.067011984498;20808.063637136365;1007.2646967713611;1022.892596277395;1025.4001409175717;1028.9588416463407;1037.201354956679;11018.944905275423;11043;11064.723381915517;11090.889091109148;11177.385243811506;455123;465611;480731;482119;483812;113896;115578;116244;122674;125762;1226.3316492511603;1234.9012079033835;1261.6845788552862;1276.7318863038865;1277.0741212620962;21248.78751212468;21250.78749212488;21320.147194112684;21619.567608647423;22070.668939966235;56594.434055658916;57792.71103644455;58451.4154858446;59396;59843;76613.61693191498;76996;77102.61448692721;77126;77888.2211177881;11715.648530544097;12106.213096148722;14500.854991450373;14881.958262921924;14955.177465239516;18456.538586535444;23674.171404000776;23755.762442375355;23945.28164155078;24096.87951560301;18248.543786404916;18383.72424413608;18516.81483185151;18676.25294988185;18712.625747485246;15945.44190953311;16919.323227070778;16928.15359232058;17406.91296543509;17485.562860928578;19088.23647054158;19194.232230710615;19283.51791205231;19288.324908628692;19296.8070319295;14082.718345632826;14536.563903082924;14701.779473307695;14729.484468043567;14952.327145278707;18110.456686299432;18885;18984.905075475086;19355.4193374199;19447.3193438229 15:37:28 INFO - PID 15196 | |3;mootools.html;1364.576981135848;1412.6962703018849;1422.054333867978;1428.7213993271316;1439.7048605035968;13955.860441395584;13972.161670299776;14278.500757420477;14521.49174778883;14558.126512409262;14599.270036498187;14802.333894974725;14840.257987100656;14845.92577037116;14888.627784305398;2684.302081458825;2725.0734750185034;2748;2748.2991837081518;2751.0371370020434;2546.1343143331264;2627.9605805912925;2631.736826317372;2642.207337798662;2668.9332766680795;2588.7928965682795;2613.163787587973;2616;2673.5722284434496;2673.8128331016837;2595.2603508000225;2613.843169409832;2623.5539958207055;2627.3037645024083;2632.8157029007784;2576.9098081567054;2577.574700174469;2603.4532748122915;2609.3346196719904;2614.9477010459686;13862.653433664138;14073.929630351886;14085.929570352082;14200.715985680332;14220;7651.9234807651765;7928.563928983904;7986.960065199695;7994.160613135595;8005.759827205193;5259.237410575445;5316.9202461963105;5425.565954723613;5530.917036244459;5532.6680399176175;1851.9907400462912;1884.7926728059902;1886.6604011277964;1917.964299278388;1927.884326940388;22937.311880643607;23181.188658397044;23298.417539561648;23327.650085248733;23401.180958666366;6211.689415529206;6552.3775241352;6642.701078451481;6823.590584564843;6827.829304267334;16133.515994520183;16135.031898086152;16140.596485087966;16157.676846463004;16163.030218186947;7590.582517961455;7633.923660763432;7752.341051010727;7763.573003484863;7797.415193860483;6212.06818977148;6236.844078898064;7201.0278612386655;7250.818729531804;7280.6723697433745;5067.822626208065;5135.204043373283;5167.870803229949;5174.689518628819;5212.50481204285;1475.6089636246404;1485.442958890416;1492.26878829375;1492.9925350373178;1494.5665756930587;884.38093334666;901.7745563609097;906.207068814787;913.2328843771264;921.7603423109906;8285.83428331442;8362.54006029662;8406.789830254293;8415.579221038923;8444.788880278042;682.2495255219219;714.8141483214401;716.5772194405326;733.1458850439178;742.357860450717;4610.585047345755;5137.717425541557;5283.841484755463;5328.254044433782;5336.466353364633;19482.610347792965;19612.019399029992;20040.799592003892;20093.49766255855;20139.19443222284;19380;19848.305309314106;19929;20101.798982010285;20155.294564690164;10758.623448179276;10881.12950963921;10968.17738669603;11032.669019929415;11134.16493762971;7960.562169080525;7973.401994850294;8077.27304542594;8098.825670277659;8152.877706834283;16517.33930642809;17023.23395447183;17386.739198911775;17396.304147833944;17456.563585910455;17590.91204543969;18192.727109093637;18203;18706.532336691693;18749.531261718566;10390.688279351632;10428.478576071318;10431;10437.843432348369;10532.473376331;12959.676008099874;13333.266670333225;13393.933030334785;13554.186748795104;13571.321433928066;10917.290376125526;11012.449377531251;11183.32900026001;11346.375949322866;11364.659060228207;10988.890111098786;11023.669289921316;11064.889351106385;11100.944495277472;11339.262947908359;9563.37838040553;9638;9740.707778766648;9744.269179811685;9751.3661611995;7299.277363550718;7328.670209840463;7344.632768361454;7383.556986580822;7539.962300188464;6953.33943275388;7003.6498175092065;7081.291870812877;7095.716171353088;7184.928150718426 15:37:28 INFO - PID 15196 | |4;prototype.html;496.7773288891726;497.7464236723494;516.8811173430112;523.8166641675414;525.1990714160906;6066.090086487018;6146.692665366731;6166.964901582478;6212;6229.159063526423;5819.505342045931;6024.9397506024925;6037.068138195779;6042.5195827022335;6055.091736239567;4909.723471897306;4922.031187525001;4946.035523073002;4950.900981980359;5003.974980125095;4806.134895718769;4892.3639926809465;4902.901941961159;4918.680285781431;4948.950510494885;4940.283658869462;4944.653874228788;4949.579285760697;4953.900921981558;4962.652614316981;4863.610911127137;4881.80395803027;4924.3352147460355;4938.308636790852;4968.726720030397;4411.911761764779;4413.558644135593;4439.889002774924;4440.267355886275;4443.888902777424;5886.646071403601;5911.733971971229;5984.491318237955;5994.13085102662;5998.190244317005;5634.492895639371;5639.295088113986;5653.462921022538;5687.658740475544;5716.628419152783;6313.684315784239;6331.430171284561;6352.205974253218;6359.21941856281;6434.420902118832;4780.076521183187;4820.855374338776;4847.83032593861;4861.586765124968;4869.56347877377;6785.9660701696175;6879.931200687979;6883.449324054114;6889.552179108342;6910.7581234657555;4950.8762280943265;4958.776855041532;4988.575971042429;4990.6257030722845;5019.29729837823;5024.723640199824;5055.862430953006;5062.11413002723;5113.130767769489;5122.795088196431;5627.5779316551425;5660.801871934463;5664.858378540487;5696.914546281809;5720.914186287209;6394.776182833672;6429;6448.709808058648;6461.160049193669;6599.340065993362;1634.3462614954115;1677.5386768638477;1684.7532825708888;1685.578605348663;1731.6450127723785;1394.595567285476;1404.3469786549304;1404.7331007108821;1444.443889102682;1447.6380904773807;5616.803411880564;5654.6889921054735;5658.943410565924;5663.433656634304;5674.943250567524;6383.840403989938;6467.191601049869;6548.6725663716625;6570.244421891448;6622.63575503352;5573.5819813514145;5667.121596152603;5712;5752.194692743019;5784.623999440107;3536.1336472564385;3543.486194501783;3551.857925682944;3581.94627080594;3595.388783906742;6438.203538363949;6496.740130394825;6526.902096468557;6556.672166391661;6607.570507917067;6762.826437775106;6773.8645227095185;6785;6794.592324460449;6808.880627220559;6401.775937842153;6444.838879027874;6457.225132984072;6506.414422701885;6531.43245621057;6554.180727409074;6557.2131344239;6645.272229220534;6703.4972377070935;6719.731210751515;6549.4760419167305;6587.901181482186;6599.703013364314;6620.966895165493;6626.83432914181;6487.481001519773;6515.967420162869;6518.608883467007;6538.509611779041;6580.177477815273;4955.835378686078;4970.627202959865;4989.326440930428;4998.325226094431;4998.850034498971;6540.2151741789385;6598.967005164944;6679.398854103154;6685.53201275906;6710.496712746662;6389.9361006389345;6439.098526206241;6475.190601174853;6475.514336424692;6505.869882602226;6416.454601358937;6449.7420103195345;6459.9031014533875;6461.353864613501;6466.515011374072;6190.41191086846;6309.684515774101;6366.840828979312;6369.172007638977;6426.518011149276;6185.907211391743;6372.235331760218;6406.711697973509;6418.390252925965;6486.805395838132;6182.6599537025895;6248.937510624835;6289.433950944437;6294.622322660655;6346.524010699124 15:37:28 INFO - PID 15196 | |5;yui.html;887.636069211623;927.1840780113499;938.4744543055893;940.5438362394237;954.0697819625864;18864.434066977996;19670.213191472343;19678.901605491952;19735.901320493394;19770.308039218595;17925.372611958584;18008.4597462076;18017.81982180178;18448.538786530342;22492.325230243077;1034.1571619130423;1045.9529321180528;1046.7697106636529;1055.0346433013783;1057.0592172966067;1069.7699994501181;1072.2922870905204;1078.202130423485;1078.757279612089;1080.3409919948824;769.29225112896;793.0998316910319;1061.8566493523392;1114.4316398636713;1131;1090.3076546393017;1121.7980763462574;1122.3097794856187;1123.4495097402255;1123.719070232442;817.2481317188201;819.4714409206028;824.5712229640553;824.5959479854888;825.7192554531429;19921.203151873906;20443.693344599844;20558.897205514026;20562.28032018872;20784.168633254652;21817.563648726937;22230.666540001912;22318.33045008636;22452.43868903274;22611.660825087638;16972.660546788997;17172.914135429244;17207.225674844663;17220.311187552485;18099.095045247817;3720.813959302024;3722.5160729105314;3737.289914916157;3738.6261373862667;3739.046543131511;119927.4003629985;121667.78332216654;129471.35264323713;130377;131476.34261828725;17395.826041739674;18139.637207255782;18183.636327273645;18213.817861821477;18315.725264121047;31374.686253137632;31428.52857207144;31745.20636984094;32199.51700724444;32234;8838.027816940132;8939.061398553189;8974.551272436353;9006.189442950166;9023.503707296162;4028.9798551007643;4070.6946978976694;4126.277901367249;4126.66986641068;4150.27370210212;5402.8919421611345;5515.558755299647;5530.668159910419;5541.861453463695;5547.7780888764;957.9712608621752;1088.2110469909253;1088.3959402531514;1110;1119.7088756923097;657.947364210862;676.2594958520413;683.7572661705024;690.9481788865754;700.5691499727631;11312;11623.59317423886;11935.641930742091;12804.93597532025;13536.526221582395;636.9872602547923;678.8438659108433;688.3323176518769;695.4610177112677;697.8953157026486;5600.915986260209;6258.092576576371;6507.7071531781185;6536.869262614816;6589.538732288694;104515.4774226124;110004;110266;110321;112048;94625.5268723652;95622;97258;97866.5106674462;98632.50683746535;84065.77488286674;85413.57293213494;88263;89254;89325.10674893297;12921.741565168832;13467.730645387233;13526.18842869431;13593.932030339785;13630.795538067136;40939.38590921198;41313.79343103265;41829;42512.362314564685;43215.56784432241;54950.72524637351;55399;56153;56650.150247747144;57175;17701.645967080844;17734.822651773833;17976.82023179804;18221.180046898186;18372.81627183711;20342.288019919233;20417.591648166657;20499.692504612143;20634.793652063887;20744.68882966787;19166.329178478685;19174.233030678617;19213.23147074157;19295.51761205981;19344.129514171615;18190.09049547491;18363.54091147732;18389.632207356044;18398.724019139456;18428.078596070412;18563.81436185675;18623.81376186275;18654.906725466284;18729.15718792685;19084.713729293795;13939.303034848419;14036.29818509091;14253.216073115664;14287.57137285883;14612.78080828767;14170.858291417366;14437.422503099759;14923.477678281643;15119;15295.311710973256 15:37:28 INFO - PID 15196 | __end_tp_report 15:37:28 INFO - PID 15196 | __start_cc_report 15:37:28 INFO - PID 15196 | _x_x_mozilla_cycle_collect,370 15:37:28 INFO - PID 15196 | __end_cc_report 15:37:28 INFO - PID 15196 | __startTimestamp1503268648605__endTimestamp 15:37:28 INFO - PID 15196 | 15:37:28 INFO - PID 15196 | ------- Summary: start ------- 15:37:28 INFO - PID 15196 | Number of tests: 6 15:37:28 INFO - PID 15196 | 15:37:28 INFO - PID 15196 | [#0] dojo.html Cycles:165 Average:6130.52 Median:6423.97 stddev:734.29 (11.4%) stddev-sans-first:697.69 15:37:28 INFO - PID 15196 | Values: 3125.8 3150.1 3169.6 3170.4 3178.5 6049.8 6135.3 6153.9 6216.2 6241.2 6120.6 6121.6 6123.4 6161.6 6179.8 5600.5 5650.7 5663.2 5667.6 5733.7 5655.5 5667.5 5684.6 5702.4 5738.9 5627.8 5643.1 5678.7 5722.7 5759.7 5599.0 5644.5 5702.7 5710.4 5743.9 5480.9 5544.8 5552.7 5554.8 5683.3 6055.4 6089.2 6122.4 6139.8 6162.7 6512.4 6570.4 6614.9 6714.2 6717.7 6595.1 6601.5 6703.6 6755.5 6761.0 6189.8 6192.7 6221.6 6236.3 6252.3 6862.6 6899.6 6912.3 6913.2 6923.8 6469.2 6530.3 6608.8 6612.4 6615.6 6597.1 6602.4 6628.9 6715.0 6734.7 6511.1 6590.6 6612.9 6656.5 6695.7 6677.5 6688.2 6698.5 6700.1 6702.3 5357.8 5397.2 5398.6 5406.8 5415.9 4530.9 4595.8 4608.1 4610.0 4632.4 5535.3 5633.7 5653.7 5717.8 5761.7 6707.3 6707.8 6709.0 6710.2 6719.0 5606.4 5778.2 5779.0 5817.3 5821.6 5928.1 5929.1 5932.9 5933.7 5934.0 6402.3 6408.7 6453.1 6495.8 6499.9 6495.8 6588.4 6645.4 6753.9 6759.7 6294.7 6393.5 6491.0 6509.1 6524.8 6643.9 6649.8 6652.7 6664.3 6672.1 6691.0 6700.7 6781.3 6784.7 6785.8 6478.4 6509.9 6514.4 6572.4 6597.7 6370.2 6458.0 6460.6 6556.1 6584.9 6437.5 6444.4 6458.5 6516.3 6520.2 6550.1 6568.9 6598.2 6630.7 6637.5 6284.7 6365.6 6424.0 6448.1 6457.8 15:37:28 INFO - PID 15196 | 15:37:28 INFO - PID 15196 | [#1] ext.html Cycles:180 Average:36583.81 Median:32737.01 stddev:52958.18 (161.8%) stddev-sans-first:53038.53 15:37:28 INFO - PID 15196 | Values: 785.7 848.8 868.0 868.5 1165.8 29093.4 29896.7 38963.4 39831.6 39909.4 39894.4 40005.2 40312.0 40391.4 40398.0 7605.3 7724.7 7743.7 7762.6 7764.5 7107.1 7260.9 7726.6 7737.8 7756.9 7654.7 7660.5 7668.2 7739.0 7740.7 7618.1 7622.8 7689.3 7697.3 7726.8 7565.2 7637.9 7646.5 7698.0 7717.8 36135.6 36158.3 36177.5 36294.5 36460.8 3495.4 3498.7 3515.9 3532.1 3551.5 29650.4 29653.3 29676.9 29864.3 29923.6 5007.4 5031.2 5059.8 5108.8 5109.4 189831.0 190464.0 190655.0 190832.0 191098.0 46561.8 46707.0 46808.5 47112.8 47155.5 48949.8 49277.5 52142.5 52746.0 52807.2 14984.3 15079.3 15206.9 15306.5 15326.8 12097.9 12241.3 12327.8 12414.3 12430.4 14103.9 14190.9 14237.9 14309.3 14355.6 5671.3 5719.9 5749.5 5810.5 5848.2 986.8 992.8 1009.7 1011.7 1013.8 22373.7 22816.9 22926.0 23020.7 23429.6 1091.2 1102.4 1115.1 1119.2 1123.2 11766.9 12012.2 12115.6 12195.1 12246.5 228607.0 228915.0 229274.0 229358.0 231452.0 50028.5 50648.0 50667.7 50692.5 50870.5 1419.9 1459.6 1462.0 1472.2 1481.9 22173.2 22224.9 22253.7 22478.4 22792.3 35472.3 35591.5 35638.3 35792.3 35879.3 189725.0 190186.0 190645.0 190913.0 192130.0 29390.7 29391.3 29485.9 29625.6 32422.2 41564.4 41657.0 41702.8 42068.4 42455.4 30986.2 31272.2 31547.5 31745.4 32178.8 30585.7 30870.5 30895.5 31011.2 31269.7 32775.5 33109.2 33204.0 33274.0 33711.8 30417.8 31049.4 32494.2 32624.0 32698.5 24275.9 24349.4 24376.6 24654.4 24800.5 15:37:28 INFO - PID 15196 | 15:37:28 INFO - PID 15196 | [#2] jquery.html Cycles:180 Average:35646.73 Median:22576.77 stddev:80159.85 (355.1%) stddev-sans-first:80341.38 15:37:28 INFO - PID 15196 | Values: 537.3 544.4 563.3 567.6 574.3 21541.0 22500.0 22574.9 22578.7 22617.3 24543.8 27158.2 27171.9 27371.7 27397.7 6201.0 6315.7 6335.8 6338.3 6352.4 6276.2 6400.5 6417.1 6417.4 6424.7 4128.9 4154.4 5423.2 6362.5 6895.5 6855.5 6879.0 6880.6 6891.7 6904.7 6790.3 6808.6 6839.4 6844.5 6868.7 30864.5 31350.0 31480.0 32439.0 32440.5 1941.9 2002.5 2005.0 2006.3 2025.9 19824.5 20546.5 20553.4 20589.5 20689.5 2419.8 2447.6 2469.3 2513.3 2567.8 133531.3 138676.0 138854.0 139338.0 140499.3 19504.3 20823.3 20899.7 21821.3 22396.6 43944.8 44187.6 44374.0 44387.6 44418.1 10914.5 11026.9 11091.0 11091.2 11137.2 9032.4 9057.6 9145.7 9252.8 9321.1 8602.4 9244.6 9468.3 10815.6 11637.3 2614.8 2624.6 2704.1 2734.9 2766.6 926.4 957.4 959.2 965.8 988.3 20221.4 20275.9 20304.9 20733.1 20808.1 1007.3 1022.9 1025.4 1029.0 1037.2 11018.9 11043.0 11064.7 11090.9 11177.4 455123.0 465611.0 480731.0 482119.0 483812.0 113896.0 115578.0 116244.0 122674.0 125762.0 1226.3 1234.9 1261.7 1276.7 1277.1 21248.8 21250.8 21320.1 21619.6 22070.7 56594.4 57792.7 58451.4 59396.0 59843.0 76613.6 76996.0 77102.6 77126.0 77888.2 11715.6 12106.2 14500.9 14882.0 14955.2 18456.5 23674.2 23755.8 23945.3 24096.9 18248.5 18383.7 18516.8 18676.3 18712.6 15945.4 16919.3 16928.2 17406.9 17485.6 19088.2 19194.2 19283.5 19288.3 19296.8 14082.7 14536.6 14701.8 14729.5 14952.3 18110.5 18885.0 18984.9 19355.4 19447.3 15:37:28 INFO - PID 15196 | 15:37:28 INFO - PID 15196 | [#3] mootools.html Cycles:180 Average:8880.78 Median:2606.39 stddev:6094.14 (233.8%) stddev-sans-first:6085.06 15:37:28 INFO - PID 15196 | Values: 1364.6 1412.7 1422.1 1428.7 1439.7 13955.9 13972.2 14278.5 14521.5 14558.1 14599.3 14802.3 14840.3 14845.9 14888.6 2684.3 2725.1 2748.0 2748.3 2751.0 2546.1 2628.0 2631.7 2642.2 2668.9 2588.8 2613.2 2616.0 2673.6 2673.8 2595.3 2613.8 2623.6 2627.3 2632.8 2576.9 2577.6 2603.5 2609.3 2614.9 13862.7 14073.9 14085.9 14200.7 14220.0 7651.9 7928.6 7987.0 7994.2 8005.8 5259.2 5316.9 5425.6 5530.9 5532.7 1852.0 1884.8 1886.7 1918.0 1927.9 22937.3 23181.2 23298.4 23327.7 23401.2 6211.7 6552.4 6642.7 6823.6 6827.8 16133.5 16135.0 16140.6 16157.7 16163.0 7590.6 7633.9 7752.3 7763.6 7797.4 6212.1 6236.8 7201.0 7250.8 7280.7 5067.8 5135.2 5167.9 5174.7 5212.5 1475.6 1485.4 1492.3 1493.0 1494.6 884.4 901.8 906.2 913.2 921.8 8285.8 8362.5 8406.8 8415.6 8444.8 682.2 714.8 716.6 733.1 742.4 4610.6 5137.7 5283.8 5328.3 5336.5 19482.6 19612.0 20040.8 20093.5 20139.2 19380.0 19848.3 19929.0 20101.8 20155.3 10758.6 10881.1 10968.2 11032.7 11134.2 7960.6 7973.4 8077.3 8098.8 8152.9 16517.3 17023.2 17386.7 17396.3 17456.6 17590.9 18192.7 18203.0 18706.5 18749.5 10390.7 10428.5 10431.0 10437.8 10532.5 12959.7 13333.3 13393.9 13554.2 13571.3 10917.3 11012.4 11183.3 11346.4 11364.7 10988.9 11023.7 11064.9 11100.9 11339.3 9563.4 9638.0 9740.7 9744.3 9751.4 7299.3 7328.7 7344.6 7383.6 7540.0 6953.3 7003.6 7081.3 7095.7 7184.9 15:37:28 INFO - PID 15196 | 15:37:28 INFO - PID 15196 | [#4] prototype.html Cycles:180 Average:5452.15 Median:6011.56 stddev:1508.40 (25.1%) stddev-sans-first:1466.05 15:37:28 INFO - PID 15196 | Values: 496.8 497.7 516.9 523.8 525.2 6066.1 6146.7 6167.0 6212.0 6229.2 5819.5 6024.9 6037.1 6042.5 6055.1 4909.7 4922.0 4946.0 4950.9 5004.0 4806.1 4892.4 4902.9 4918.7 4949.0 4940.3 4944.7 4949.6 4953.9 4962.7 4863.6 4881.8 4924.3 4938.3 4968.7 4411.9 4413.6 4439.9 4440.3 4443.9 5886.6 5911.7 5984.5 5994.1 5998.2 5634.5 5639.3 5653.5 5687.7 5716.6 6313.7 6331.4 6352.2 6359.2 6434.4 4780.1 4820.9 4847.8 4861.6 4869.6 6786.0 6879.9 6883.4 6889.6 6910.8 4950.9 4958.8 4988.6 4990.6 5019.3 5024.7 5055.9 5062.1 5113.1 5122.8 5627.6 5660.8 5664.9 5696.9 5720.9 6394.8 6429.0 6448.7 6461.2 6599.3 1634.3 1677.5 1684.8 1685.6 1731.6 1394.6 1404.3 1404.7 1444.4 1447.6 5616.8 5654.7 5658.9 5663.4 5674.9 6383.8 6467.2 6548.7 6570.2 6622.6 5573.6 5667.1 5712.0 5752.2 5784.6 3536.1 3543.5 3551.9 3581.9 3595.4 6438.2 6496.7 6526.9 6556.7 6607.6 6762.8 6773.9 6785.0 6794.6 6808.9 6401.8 6444.8 6457.2 6506.4 6531.4 6554.2 6557.2 6645.3 6703.5 6719.7 6549.5 6587.9 6599.7 6621.0 6626.8 6487.5 6516.0 6518.6 6538.5 6580.2 4955.8 4970.6 4989.3 4998.3 4998.9 6540.2 6599.0 6679.4 6685.5 6710.5 6389.9 6439.1 6475.2 6475.5 6505.9 6416.5 6449.7 6459.9 6461.4 6466.5 6190.4 6309.7 6366.8 6369.2 6426.5 6185.9 6372.2 6406.7 6418.4 6486.8 6182.7 6248.9 6289.4 6294.6 6346.5 15:37:28 INFO - PID 15196 | 15:37:28 INFO - PID 15196 | [#5] yui.html Cycles:180 Average:23696.80 Median:19845.76 stddev:31602.32 (159.2%) stddev-sans-first:31644.56 15:37:28 INFO - PID 15196 | Values: 887.6 927.2 938.5 940.5 954.1 18864.4 19670.2 19678.9 19735.9 19770.3 17925.4 18008.5 18017.8 18448.5 22492.3 1034.2 1046.0 1046.8 1055.0 1057.1 1069.8 1072.3 1078.2 1078.8 1080.3 769.3 793.1 1061.9 1114.4 1131.0 1090.3 1121.8 1122.3 1123.4 1123.7 817.2 819.5 824.6 824.6 825.7 19921.2 20443.7 20558.9 20562.3 20784.2 21817.6 22230.7 22318.3 22452.4 22611.7 16972.7 17172.9 17207.2 17220.3 18099.1 3720.8 3722.5 3737.3 3738.6 3739.0 119927.4 121667.8 129471.4 130377.0 131476.3 17395.8 18139.6 18183.6 18213.8 18315.7 31374.7 31428.5 31745.2 32199.5 32234.0 8838.0 8939.1 8974.6 9006.2 9023.5 4029.0 4070.7 4126.3 4126.7 4150.3 5402.9 5515.6 5530.7 5541.9 5547.8 958.0 1088.2 1088.4 1110.0 1119.7 657.9 676.3 683.8 690.9 700.6 11312.0 11623.6 11935.6 12804.9 13536.5 637.0 678.8 688.3 695.5 697.9 5600.9 6258.1 6507.7 6536.9 6589.5 104515.5 110004.0 110266.0 110321.0 112048.0 94625.5 95622.0 97258.0 97866.5 98632.5 84065.8 85413.6 88263.0 89254.0 89325.1 12921.7 13467.7 13526.2 13593.9 13630.8 40939.4 41313.8 41829.0 42512.4 43215.6 54950.7 55399.0 56153.0 56650.2 57175.0 17701.6 17734.8 17976.8 18221.2 18372.8 20342.3 20417.6 20499.7 20634.8 20744.7 19166.3 19174.2 19213.2 19295.5 19344.1 18190.1 18363.5 18389.6 18398.7 18428.1 18563.8 18623.8 18654.9 18729.2 19084.7 13939.3 14036.3 14253.2 14287.6 14612.8 14170.9 14437.4 14923.5 15119.0 15295.3 15:37:28 INFO - PID 15196 | -------- Summary: end -------- 15:37:28 INFO - PID 15196 | 15:37:29 INFO - TEST-INFO | 15196: exit 0 15:37:29 INFO - TEST-OK | dromaeo_css | took 1115324ms 15:37:29 INFO - TEST-START | kraken 15:37:29 INFO - Initialising browser for kraken test... 15:37:29 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55837/getInfo.html -profile /tmp/tmpWj_P8E/profile 15:37:29 INFO - TEST-INFO | started process 15622 (/builds/slave/test/build/application/firefox/firefox http://localhost:55837/getInfo.html) 15:37:34 INFO - TEST-INFO | 15622: exit 0 15:37:34 INFO - Browser initialized. 15:37:34 INFO - Running cycle 1/1 for kraken test... 15:37:34 INFO - TEST-INFO | started process 15807 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWj_P8E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:37:35 INFO - PID 15807 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 15:37:36 INFO - PID 15807 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 15:37:36 INFO - PID 15807 | 15:37:36 INFO - PID 15807 | (/builds/slave/test/build/application/firefox/firefox:15868): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:37:36 INFO - PID 15807 | 15:37:36 INFO - PID 15807 | 15:37:36 INFO - PID 15807 | (/builds/slave/test/build/application/firefox/firefox:15925): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:37:36 INFO - PID 15807 | 15:37:37 INFO - PID 15807 | __metrics Screen width/height:1600/1200 15:37:37 INFO - PID 15807 | colorDepth:24 15:37:37 INFO - PID 15807 | Browser inner width/height: 1024/768 15:37:37 INFO - PID 15807 | __metrics 15:37:46 INFO - PID 15807 | RSS: Main: 198459392 15:37:46 INFO - PID 15807 | 15:37:49 INFO - PID 15807 | Cycle 1(1): loaded http://localhost:55837/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55837/tests/kraken/driver.html?testName=audio-beat-detection) 15:37:50 INFO - PID 15807 | RSS: Main: 207159296 15:37:50 INFO - PID 15807 | 15:37:52 INFO - PID 15807 | Cycle 1(1): loaded http://localhost:55837/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55837/tests/kraken/driver.html?testName=audio-dft) 15:37:53 INFO - PID 15807 | RSS: Main: 207601664 15:37:53 INFO - PID 15807 | 15:37:56 INFO - PID 15807 | Cycle 1(1): loaded http://localhost:55837/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55837/tests/kraken/driver.html?testName=audio-fft) 15:37:57 INFO - PID 15807 | RSS: Main: 200134656 15:37:57 INFO - PID 15807 | 15:37:59 INFO - PID 15807 | Cycle 1(1): loaded http://localhost:55837/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55837/tests/kraken/driver.html?testName=audio-oscillator) 15:38:00 INFO - PID 15807 | RSS: Main: 202551296 15:38:00 INFO - PID 15807 | 15:38:02 INFO - PID 15807 | Cycle 1(1): loaded http://localhost:55837/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55837/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:38:02 INFO - PID 15807 | RSS: Main: 203849728 15:38:02 INFO - PID 15807 | 15:38:06 INFO - PID 15807 | Cycle 1(1): loaded http://localhost:55837/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55837/tests/kraken/driver.html?testName=imaging-darkroom) 15:38:06 INFO - PID 15807 | RSS: Main: 202092544 15:38:06 INFO - PID 15807 | 15:38:10 INFO - PID 15807 | Cycle 1(1): loaded http://localhost:55837/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55837/tests/kraken/driver.html?testName=imaging-desaturate) 15:38:10 INFO - PID 15807 | RSS: Main: 202649600 15:38:10 INFO - PID 15807 | 15:38:13 INFO - PID 15807 | Cycle 1(1): loaded http://localhost:55837/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55837/tests/kraken/driver.html?testName=json-parse-financial) 15:38:14 INFO - PID 15807 | RSS: Main: 204148736 15:38:14 INFO - PID 15807 | 15:38:16 INFO - PID 15807 | Cycle 1(1): loaded http://localhost:55837/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55837/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:38:16 INFO - PID 15807 | RSS: Main: 204595200 15:38:16 INFO - PID 15807 | 15:38:18 INFO - PID 15807 | Cycle 1(1): loaded http://localhost:55837/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55837/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:38:19 INFO - PID 15807 | RSS: Main: 204492800 15:38:19 INFO - PID 15807 | 15:38:21 INFO - PID 15807 | Cycle 1(1): loaded http://localhost:55837/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55837/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:38:22 INFO - PID 15807 | RSS: Main: 204091392 15:38:22 INFO - PID 15807 | 15:38:24 INFO - PID 15807 | Cycle 1(1): loaded http://localhost:55837/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55837/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:38:25 INFO - PID 15807 | RSS: Main: 204103680 15:38:25 INFO - PID 15807 | 15:38:28 INFO - PID 15807 | Cycle 1(1): loaded http://localhost:55837/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55837/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:38:29 INFO - PID 15807 | RSS: Main: 204734464 15:38:29 INFO - PID 15807 | 15:38:31 INFO - PID 15807 | Cycle 1(1): loaded http://localhost:55837/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55837/tests/kraken/driver.html?testName=ai-astar) 15:38:31 INFO - PID 15807 | RSS: Main: 207790080 15:38:31 INFO - PID 15807 | 15:38:31 INFO - PID 15807 | __start_tp_report 15:38:31 INFO - PID 15807 | _x_x_mozilla_page_load 15:38:31 INFO - PID 15807 | _x_x_mozilla_page_load_details 15:38:31 INFO - PID 15807 | |i|pagename|runs| 15:38:31 INFO - PID 15807 | |0;ai-astar;104;116;100;108;117;111;111;100;117;111 15:38:31 INFO - PID 15807 | |1;audio-beat-detection;150;119;147;192;118;149;147;128;182;121 15:38:31 INFO - PID 15807 | |2;audio-dft;164;162;169;164;163;181;175;164;166;165 15:38:31 INFO - PID 15807 | |3;audio-fft;76;75;74;178;77;82;81;90;102;82 15:38:31 INFO - PID 15807 | |4;audio-oscillator;84;90;129;79;88;78;139;82;80;137 15:38:31 INFO - PID 15807 | |5;imaging-gaussian-blur;123;125;115;115;115;122;118;123;124;124 15:38:31 INFO - PID 15807 | |6;imaging-darkroom;157;150;151;153;161;158;151;151;157;156 15:38:31 INFO - PID 15807 | |7;imaging-desaturate;94;95;95;96;98;94;95;96;94;101 15:38:31 INFO - PID 15807 | |8;json-parse-financial;58;55;56;55;57;54;55;55;55;55 15:38:31 INFO - PID 15807 | |9;json-stringify-tinderbox;56;58;61;58;62;62;60;65;55;55 15:38:31 INFO - PID 15807 | |10;stanford-crypto-aes;78;80;84;78;77;87;78;81;84;79 15:38:31 INFO - PID 15807 | |11;stanford-crypto-ccm;132;123;131;129;154;121;136;129;133;165 15:38:31 INFO - PID 15807 | |12;stanford-crypto-pbkdf2;183;185;186;179;181;177;175;188;180;178 15:38:31 INFO - PID 15807 | |13;stanford-crypto-sha256-iterative;71;72;68;71;71;73;68;67;75;66 15:38:31 INFO - PID 15807 | __end_tp_report 15:38:31 INFO - PID 15807 | __start_cc_report 15:38:31 INFO - PID 15807 | _x_x_mozilla_cycle_collect,952 15:38:31 INFO - PID 15807 | __end_cc_report 15:38:31 INFO - PID 15807 | __startTimestamp1503268711426__endTimestamp 15:38:31 INFO - PID 15807 | 15:38:31 INFO - PID 15807 | ------- Summary: start ------- 15:38:31 INFO - PID 15807 | Number of tests: 14 15:38:31 INFO - PID 15807 | 15:38:31 INFO - PID 15807 | [#0] ai-astar Cycles:10 Average:109.50 Median:111.00 stddev:6.45 (5.8%) stddev-sans-first:6.53 15:38:31 INFO - PID 15807 | Values: 104.0 116.0 100.0 108.0 117.0 111.0 111.0 100.0 117.0 111.0 15:38:31 INFO - PID 15807 | 15:38:31 INFO - PID 15807 | [#1] audio-beat-detection Cycles:10 Average:145.30 Median:148.00 stddev:25.60 (17.3%) stddev-sans-first:27.09 15:38:31 INFO - PID 15807 | Values: 150.0 119.0 147.0 192.0 118.0 149.0 147.0 128.0 182.0 121.0 15:38:31 INFO - PID 15807 | 15:38:31 INFO - PID 15807 | [#2] audio-dft Cycles:10 Average:167.30 Median:165.50 stddev:6.11 (3.7%) stddev-sans-first:6.36 15:38:31 INFO - PID 15807 | Values: 164.0 162.0 169.0 164.0 163.0 181.0 175.0 164.0 166.0 165.0 15:38:31 INFO - PID 15807 | 15:38:31 INFO - PID 15807 | [#3] audio-fft Cycles:10 Average:91.70 Median:79.00 stddev:31.47 (39.8%) stddev-sans-first:32.86 15:38:31 INFO - PID 15807 | Values: 76.0 75.0 74.0 178.0 77.0 82.0 81.0 90.0 102.0 82.0 15:38:31 INFO - PID 15807 | 15:38:31 INFO - PID 15807 | [#4] audio-oscillator Cycles:10 Average:98.60 Median:81.00 stddev:25.52 (31.5%) stddev-sans-first:26.51 15:38:31 INFO - PID 15807 | Values: 84.0 90.0 129.0 79.0 88.0 78.0 139.0 82.0 80.0 137.0 15:38:31 INFO - PID 15807 | 15:38:31 INFO - PID 15807 | [#5] imaging-gaussian-blur Cycles:10 Average:120.40 Median:123.00 stddev:4.17 (3.4%) stddev-sans-first:4.31 15:38:31 INFO - PID 15807 | Values: 123.0 125.0 115.0 115.0 115.0 122.0 118.0 123.0 124.0 124.0 15:38:31 INFO - PID 15807 | 15:38:31 INFO - PID 15807 | [#6] imaging-darkroom Cycles:10 Average:154.50 Median:156.50 stddev:3.78 (2.4%) stddev-sans-first:3.90 15:38:31 INFO - PID 15807 | Values: 157.0 150.0 151.0 153.0 161.0 158.0 151.0 151.0 157.0 156.0 15:38:31 INFO - PID 15807 | 15:38:31 INFO - PID 15807 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:95.00 stddev:2.20 (2.3%) stddev-sans-first:2.24 15:38:31 INFO - PID 15807 | Values: 94.0 95.0 95.0 96.0 98.0 94.0 95.0 96.0 94.0 101.0 15:38:31 INFO - PID 15807 | 15:38:31 INFO - PID 15807 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:55.00 stddev:1.18 (2.1%) stddev-sans-first:0.83 15:38:31 INFO - PID 15807 | Values: 58.0 55.0 56.0 55.0 57.0 54.0 55.0 55.0 55.0 55.0 15:38:31 INFO - PID 15807 | 15:38:31 INFO - PID 15807 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:60.50 stddev:3.36 (5.6%) stddev-sans-first:3.36 15:38:31 INFO - PID 15807 | Values: 56.0 58.0 61.0 58.0 62.0 62.0 60.0 65.0 55.0 55.0 15:38:31 INFO - PID 15807 | 15:38:31 INFO - PID 15807 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:80.50 stddev:3.34 (4.1%) stddev-sans-first:3.41 15:38:31 INFO - PID 15807 | Values: 78.0 80.0 84.0 78.0 77.0 87.0 78.0 81.0 84.0 79.0 15:38:31 INFO - PID 15807 | 15:38:31 INFO - PID 15807 | [#11] stanford-crypto-ccm Cycles:10 Average:135.30 Median:132.50 stddev:13.75 (10.4%) stddev-sans-first:14.53 15:38:31 INFO - PID 15807 | Values: 132.0 123.0 131.0 129.0 154.0 121.0 136.0 129.0 133.0 165.0 15:38:31 INFO - PID 15807 | 15:38:31 INFO - PID 15807 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.20 Median:182.00 stddev:4.21 (2.3%) stddev-sans-first:4.42 15:38:31 INFO - PID 15807 | Values: 183.0 185.0 186.0 179.0 181.0 177.0 175.0 188.0 180.0 178.0 15:38:31 INFO - PID 15807 | 15:38:31 INFO - PID 15807 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:71.00 stddev:2.86 (4.0%) stddev-sans-first:3.02 15:38:31 INFO - PID 15807 | Values: 71.0 72.0 68.0 71.0 71.0 73.0 68.0 67.0 75.0 66.0 15:38:31 INFO - PID 15807 | -------- Summary: end -------- 15:38:31 INFO - PID 15807 | 15:38:31 INFO - PID 15807 | 15:38:31 INFO - PID 15807 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150079,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 15:38:31 INFO - PID 15807 | 15:38:31 INFO - PID 15807 | 15:38:31 INFO - PID 15807 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 15:38:31 INFO - PID 15807 | 15:38:31 INFO - PID 15807 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 15:38:32 INFO - TEST-INFO | 15807: exit 0 15:38:32 INFO - TEST-OK | kraken | took 62860ms 15:38:32 INFO - SUITE-END | took 1178s 15:38:32 INFO - Completed test suite (00:19:38) 15:38:32 INFO - javascript benchmark 15:38:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8521.3912536903, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3125.8124512529243, 3150.149459645897, 3169.587953566036, 3170.3976244513556, 3178.4755515339957, 6049.818505444844, 6135.263768347799, 6153.9076913846275, 6216.191895053642, 6241.188645476093, 6120.571559990803, 6121.571489995702, 6123.357047510014, 6161.568690191689, 6179.7837075702355, 5600.4959553640165, 5650.74571644276, 5663.150527420899, 5667.574931880125, 5733.684647344395, 5655.462731040565, 5667.489925906668, 5684.602077854552, 5702.429757024306, 5738.885222295552, 5627.846291510231, 5643.125315576092, 5678.659280443166, 5722.7424765885635, 5759.740811663464, 5599.020171469997, 5644.520215781664, 5702.657840529581, 5710.428957104277, 5743.8564035899435, 5480.862978425532, 5544.750486228089, 5552.7223638817895, 5554.750036248379, 5683.2895888014, 6055.364186760371, 6089.177960975256, 6122.448979591813, 6139.754409823602, 6162.7226774795245, 6512.381323774234, 6570.408663220333, 6614.900776488356, 6714.227863795629, 6717.731290748364, 6595.10966019586, 6601.537892347537, 6703.564268322592, 6755.49333799967, 6761.0, 6189.81430557084, 6192.690365481708, 6221.564490485668, 6236.282827474854, 6252.3122456529745, 6862.622555759481, 6899.6205208713, 6912.343327383991, 6913.2049814270995, 6923.757668481579, 6469.159009328757, 6530.314316996742, 6608.768693095719, 6612.437942774822, 6615.636140012345, 6597.1423714916755, 6602.372774586406, 6628.8674226515195, 6715.026321183401, 6734.696938637773, 6511.120998665215, 6590.637514936724, 6612.86774264512, 6656.500762442836, 6695.732170713214, 6677.465802735769, 6688.230853451818, 6698.4641228701585, 6700.095487109178, 6702.329767023356, 5357.8392648220615, 5397.2443857859935, 5398.568114550826, 5406.83779486616, 5415.918761218585, 4530.932036019462, 4595.839145629954, 4608.147492713859, 4609.953900460952, 4632.397788287569, 5535.335759708861, 5633.690147041952, 5653.66078035311, 5717.771289148471, 5761.740721667535, 6707.262201157869, 6707.832304192337, 6709.0, 6710.228323742832, 6719.025741267489, 5606.383297837235, 5778.162166485836, 5778.971105144447, 5817.331006934172, 5821.592488525847, 5928.081147422156, 5929.05135178378, 5932.911006334908, 5933.703314834327, 5933.970330148408, 6402.295747467775, 6408.679566021773, 6453.146589935521, 6495.805125846232, 6499.8700025999215, 6495.837604059936, 6588.40704336612, 6645.435138013323, 6753.864922701617, 6759.729610815709, 6294.748210071546, 6393.488520918222, 6491.026346048131, 6509.121268628674, 6524.771632992823, 6643.933560664332, 6649.833754155991, 6652.733890644514, 6664.266930637723, 6672.132622759011, 6691.0, 6700.698468569024, 6781.321867813179, 6784.728610855511, 6785.762498312535, 6478.449331806661, 6509.902351464826, 6514.3811337922825, 6572.441342485751, 6597.703103360456, 6370.235571731422, 6458.0, 6460.612363258219, 6556.082148499309, 6584.934150658623, 6437.452816510649, 6444.420002199637, 6458.54790164684, 6516.348365163635, 6520.217573891164, 6550.082988381535, 6568.901466477911, 6598.241202261609, 6630.701618427086, 6637.502187336066, 6284.717187726472, 6365.61806291624, 6423.96788016057, 6448.097266382804, 6457.838554036187], "value": 6075.065064508415, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [785.7249962513117, 848.8217474330391, 868.0494858130347, 868.5396739727946, 1165.8309545115965, 29093.418131637354, 29896.701032989662, 38963.41554876679, 39831.60168398315, 39909.40135897964, 39894.401583976265, 40005.199896002065, 40312.0, 40391.39412908801, 40398.0, 7605.277498637634, 7724.652390642406, 7743.728969486069, 7762.611869406535, 7764.495307805003, 7107.147142342926, 7260.927390726104, 7726.575038372887, 7737.806554836146, 7756.883646745303, 7654.655540500691, 7660.540367577935, 7668.233176682315, 7738.961305193466, 7740.729074482394, 7618.085829700416, 7622.771316860503, 7689.307962283366, 7697.307242348215, 7726.7681969541, 7565.167831538582, 7637.885431718529, 7646.502977306457, 7698.0, 7717.768466946, 36135.63864361349, 36158.27683446316, 36177.457338139946, 36294.45558316627, 36460.81769591162, 3495.353359628477, 3498.667626575497, 3515.859365625372, 3532.0993146747674, 3551.520544726455, 29650.406991860258, 29653.258668533243, 29676.851615741998, 29864.253393665116, 29923.551146732818, 5007.37407824022, 5031.245313203012, 5059.797608095671, 5108.846734597968, 5109.386873575158, 189831.0, 190464.0, 190655.0, 190831.9999999986, 191098.0, 46561.767191163824, 46707.0, 46808.53191468042, 47112.7644361776, 47155.52844471511, 48949.75525122351, 49277.507224928006, 52142.47857521452, 52746.0, 52807.207891881655, 14984.325705343286, 15079.321430535652, 15206.923965380101, 15306.540803775904, 15326.770098448533, 12097.939510302569, 12241.326727030098, 12327.75344493123, 12414.255144691348, 12430.37848107591, 14103.929480352532, 14190.85809141916, 14237.85762142386, 14309.284535773379, 14355.56933292003, 5671.347795003628, 5719.885602287931, 5749.540036797046, 5810.4770570648, 5848.181254624356, 986.8026394720941, 992.7964767222846, 1009.7374682582434, 1011.7217765114652, 1013.7972405518926, 22373.664395034088, 22816.885915570318, 22926.0, 23020.65469017966, 23429.648555271684, 1091.1870656361061, 1102.4377567440504, 1115.1134847795859, 1119.1885882734953, 1123.185690374472, 11766.88233117675, 12012.159148859497, 12115.575954841539, 12195.146339756131, 12246.510139594495, 228607.0, 228915.0, 229274.0, 229358.0, 231452.0, 50028.49971500311, 50648.0, 50667.74666126646, 50692.49307506951, 50870.49129508658, 1419.8864090872705, 1459.5986103821533, 1461.956141315741, 1472.2197235465221, 1481.8814494840603, 22173.22393716212, 22224.88887555552, 22253.666195006765, 22478.438039049153, 22792.31623051311, 35472.29055418826, 35591.46612800758, 35638.287234254654, 35792.28415431625, 35879.28241435209, 189725.0, 190186.0, 190645.0, 190913.0, 192130.0, 29390.706092938795, 29391.265218368855, 29485.85257073701, 29625.5556166662, 32422.189445264055, 41564.37653435261, 41657.0, 41702.79148604238, 42068.36897446479, 42455.36316955186, 30986.225344366572, 31272.21819454441, 31547.52678709867, 31745.365092698477, 32178.83910580432, 30585.694143058285, 30870.53694194544, 30895.536566951963, 31011.224719382197, 31269.687303127586, 32775.50836737498, 33109.17227069342, 33204.0, 33274.00177994664, 33711.83144084362, 30417.847910760305, 31049.44752762398, 32494.187645309055, 32624.0, 32698.509522356708, 24275.878620606785, 24349.391265217804, 24376.6343504844, 24654.383640409134, 24800.50398991974], "value": 16750.13322633608, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [537.2559005777, 544.4201924949931, 563.2508763344752, 567.5913342393477, 574.2993547871597, 21541.0, 22500.0, 22574.887125564368, 22578.661320080213, 22617.321480355575, 24543.754562454415, 27158.18525444235, 27171.86414067927, 27371.726282737167, 27397.726022739767, 6201.0, 6315.74737010519, 6335.841603959915, 6338.33447488014, 6352.396522330371, 6276.215473065867, 6400.4559612432995, 6417.101605775195, 6417.39034791694, 6424.678766061702, 4128.855490057848, 4154.4183814266025, 5423.2136340230645, 6362.45919096875, 6895.482838787111, 6855.485838562103, 6878.965605171992, 6880.587164770105, 6891.724331026753, 6904.723811047552, 6790.253072162058, 6808.5914845109455, 6839.350261725128, 6844.486663500207, 6868.690908909061, 30864.53703194454, 31350.0, 31479.953803002732, 32439.0, 32440.513392299134, 1941.883486990785, 2002.4793553676004, 2005.0476023888682, 2006.2677122850055, 2025.878447293167, 19824.504387390432, 20546.486337841674, 20553.38339849792, 20589.4852628684, 20689.482762930897, 2419.806415486757, 2447.5716749568933, 2469.2839076667747, 2513.296277042431, 2567.8074144439242, 133531.33234333864, 138676.0, 138854.0, 139338.0, 140499.29750351285, 19504.31356904215, 20823.271185508736, 20899.68650470244, 21821.345359639236, 22396.55206895853, 43944.78027609841, 44187.55812441899, 44374.00633942961, 44387.55612443899, 44418.11163776771, 10914.454277286104, 11026.944865275782, 11091.0, 11091.22361434708, 11137.164712646583, 9032.36773425867, 9057.592408341641, 9145.725628231165, 9252.814943701089, 9321.067893210624, 8602.440841345293, 9244.583993720298, 9468.337216394786, 10815.621453249098, 11637.301761894314, 2614.8494662348508, 2624.619529963567, 2704.107644477318, 2734.9042783502878, 2766.5573508238585, 926.416357694648, 957.4351132831663, 959.1559427703576, 965.8406362950175, 988.3081842710131, 20221.393358198984, 20275.898620507098, 20304.898475507824, 20733.067011984498, 20808.063637136365, 1007.2646967713611, 1022.892596277395, 1025.4001409175717, 1028.9588416463407, 1037.201354956679, 11018.944905275423, 11043.0, 11064.723381915517, 11090.889091109148, 11177.385243811506, 455123.0, 465611.0, 480731.0, 482119.0, 483812.0, 113896.0, 115578.0, 116244.0, 122674.0, 125762.0, 1226.3316492511603, 1234.9012079033835, 1261.6845788552862, 1276.7318863038865, 1277.0741212620962, 21248.78751212468, 21250.78749212488, 21320.147194112684, 21619.567608647423, 22070.668939966235, 56594.434055658916, 57792.71103644455, 58451.4154858446, 59396.0, 59843.0, 76613.61693191498, 76996.0, 77102.61448692721, 77126.0, 77888.2211177881, 11715.648530544097, 12106.213096148722, 14500.854991450373, 14881.958262921924, 14955.177465239516, 18456.538586535444, 23674.171404000776, 23755.762442375355, 23945.28164155078, 24096.87951560301, 18248.543786404916, 18383.72424413608, 18516.81483185151, 18676.25294988185, 18712.625747485246, 15945.44190953311, 16919.323227070778, 16928.15359232058, 17406.91296543509, 17485.562860928578, 19088.23647054158, 19194.232230710615, 19283.51791205231, 19288.324908628692, 19296.8070319295, 14082.718345632826, 14536.563903082924, 14701.779473307695, 14729.484468043567, 14952.327145278707, 18110.456686299432, 18885.0, 18984.905075475086, 19355.4193374199, 19447.3193438229], "value": 12495.006432936569, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1364.576981135848, 1412.6962703018849, 1422.054333867978, 1428.7213993271316, 1439.7048605035968, 13955.860441395584, 13972.161670299776, 14278.500757420477, 14521.49174778883, 14558.126512409262, 14599.270036498187, 14802.333894974725, 14840.257987100656, 14845.92577037116, 14888.627784305398, 2684.302081458825, 2725.0734750185034, 2748.0, 2748.2991837081518, 2751.0371370020434, 2546.1343143331264, 2627.9605805912925, 2631.736826317372, 2642.207337798662, 2668.9332766680795, 2588.7928965682795, 2613.163787587973, 2616.0, 2673.5722284434496, 2673.8128331016837, 2595.2603508000225, 2613.843169409832, 2623.5539958207055, 2627.3037645024083, 2632.8157029007784, 2576.9098081567054, 2577.574700174469, 2603.4532748122915, 2609.3346196719904, 2614.9477010459686, 13862.653433664138, 14073.929630351886, 14085.929570352082, 14200.715985680332, 14220.0, 7651.9234807651765, 7928.563928983904, 7986.960065199695, 7994.160613135595, 8005.759827205193, 5259.237410575445, 5316.9202461963105, 5425.565954723613, 5530.917036244459, 5532.6680399176175, 1851.9907400462912, 1884.7926728059902, 1886.6604011277964, 1917.964299278388, 1927.884326940388, 22937.311880643607, 23181.188658397044, 23298.417539561648, 23327.650085248733, 23401.180958666366, 6211.689415529206, 6552.3775241352, 6642.701078451481, 6823.590584564843, 6827.829304267334, 16133.515994520183, 16135.031898086152, 16140.596485087966, 16157.676846463004, 16163.030218186947, 7590.582517961455, 7633.923660763432, 7752.341051010727, 7763.573003484863, 7797.415193860483, 6212.06818977148, 6236.844078898064, 7201.0278612386655, 7250.818729531804, 7280.6723697433745, 5067.822626208065, 5135.204043373283, 5167.870803229949, 5174.689518628819, 5212.50481204285, 1475.6089636246404, 1485.442958890416, 1492.26878829375, 1492.9925350373178, 1494.5665756930587, 884.38093334666, 901.7745563609097, 906.207068814787, 913.2328843771264, 921.7603423109906, 8285.83428331442, 8362.54006029662, 8406.789830254293, 8415.579221038923, 8444.788880278042, 682.2495255219219, 714.8141483214401, 716.5772194405326, 733.1458850439178, 742.357860450717, 4610.585047345755, 5137.717425541557, 5283.841484755463, 5328.254044433782, 5336.466353364633, 19482.610347792965, 19612.019399029992, 20040.799592003892, 20093.49766255855, 20139.19443222284, 19380.0, 19848.305309314106, 19929.0, 20101.798982010285, 20155.294564690164, 10758.623448179276, 10881.12950963921, 10968.17738669603, 11032.669019929415, 11134.16493762971, 7960.562169080525, 7973.401994850294, 8077.27304542594, 8098.825670277659, 8152.877706834283, 16517.33930642809, 17023.23395447183, 17386.739198911775, 17396.304147833944, 17456.563585910455, 17590.91204543969, 18192.727109093637, 18203.0, 18706.532336691693, 18749.531261718566, 10390.688279351632, 10428.478576071318, 10431.0, 10437.843432348369, 10532.473376331, 12959.676008099874, 13333.266670333225, 13393.933030334785, 13554.186748795104, 13571.321433928066, 10917.290376125526, 11012.449377531251, 11183.32900026001, 11346.375949322866, 11364.659060228207, 10988.890111098786, 11023.669289921316, 11064.889351106385, 11100.944495277472, 11339.262947908359, 9563.37838040553, 9638.0, 9740.707778766648, 9744.269179811685, 9751.3661611995, 7299.277363550718, 7328.670209840463, 7344.632768361454, 7383.556986580822, 7539.962300188464, 6953.33943275388, 7003.6498175092065, 7081.291870812877, 7095.716171353088, 7184.928150718426], "value": 6419.6066441465755, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.7773288891726, 497.7464236723494, 516.8811173430112, 523.8166641675414, 525.1990714160906, 6066.090086487018, 6146.692665366731, 6166.964901582478, 6212.0, 6229.159063526423, 5819.505342045931, 6024.9397506024925, 6037.068138195779, 6042.5195827022335, 6055.091736239567, 4909.723471897306, 4922.031187525001, 4946.035523073002, 4950.900981980359, 5003.974980125095, 4806.134895718769, 4892.3639926809465, 4902.901941961159, 4918.680285781431, 4948.950510494885, 4940.283658869462, 4944.653874228788, 4949.579285760697, 4953.900921981558, 4962.652614316981, 4863.610911127137, 4881.80395803027, 4924.3352147460355, 4938.308636790852, 4968.726720030397, 4411.911761764779, 4413.558644135593, 4439.889002774924, 4440.267355886275, 4443.888902777424, 5886.646071403601, 5911.733971971229, 5984.491318237955, 5994.13085102662, 5998.190244317005, 5634.492895639371, 5639.295088113986, 5653.462921022538, 5687.658740475544, 5716.628419152783, 6313.684315784239, 6331.430171284561, 6352.205974253218, 6359.21941856281, 6434.420902118832, 4780.076521183187, 4820.855374338776, 4847.83032593861, 4861.586765124968, 4869.56347877377, 6785.9660701696175, 6879.931200687979, 6883.449324054114, 6889.552179108342, 6910.7581234657555, 4950.8762280943265, 4958.776855041532, 4988.575971042429, 4990.6257030722845, 5019.29729837823, 5024.723640199824, 5055.862430953006, 5062.11413002723, 5113.130767769489, 5122.795088196431, 5627.5779316551425, 5660.801871934463, 5664.858378540487, 5696.914546281809, 5720.914186287209, 6394.776182833672, 6429.0, 6448.709808058648, 6461.160049193669, 6599.340065993362, 1634.3462614954115, 1677.5386768638477, 1684.7532825708888, 1685.578605348663, 1731.6450127723785, 1394.595567285476, 1404.3469786549304, 1404.7331007108821, 1444.443889102682, 1447.6380904773807, 5616.803411880564, 5654.6889921054735, 5658.943410565924, 5663.433656634304, 5674.943250567524, 6383.840403989938, 6467.191601049869, 6548.6725663716625, 6570.244421891448, 6622.63575503352, 5573.5819813514145, 5667.121596152603, 5712.0, 5752.194692743019, 5784.623999440107, 3536.1336472564385, 3543.486194501783, 3551.857925682944, 3581.94627080594, 3595.388783906742, 6438.203538363949, 6496.740130394825, 6526.902096468557, 6556.672166391661, 6607.570507917067, 6762.826437775106, 6773.8645227095185, 6785.0, 6794.592324460449, 6808.880627220559, 6401.775937842153, 6444.838879027874, 6457.225132984072, 6506.414422701885, 6531.43245621057, 6554.180727409074, 6557.2131344239, 6645.272229220534, 6703.4972377070935, 6719.731210751515, 6549.4760419167305, 6587.901181482186, 6599.703013364314, 6620.966895165493, 6626.83432914181, 6487.481001519773, 6515.967420162869, 6518.608883467007, 6538.509611779041, 6580.177477815273, 4955.835378686078, 4970.627202959865, 4989.326440930428, 4998.325226094431, 4998.850034498971, 6540.2151741789385, 6598.967005164944, 6679.398854103154, 6685.53201275906, 6710.496712746662, 6389.9361006389345, 6439.098526206241, 6475.190601174853, 6475.514336424692, 6505.869882602226, 6416.454601358937, 6449.7420103195345, 6459.9031014533875, 6461.353864613501, 6466.515011374072, 6190.41191086846, 6309.684515774101, 6366.840828979312, 6369.172007638977, 6426.518011149276, 6185.907211391743, 6372.235331760218, 6406.711697973509, 6418.390252925965, 6486.805395838132, 6182.6599537025895, 6248.937510624835, 6289.433950944437, 6294.622322660655, 6346.524010699124], "value": 5019.120162865657, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [887.636069211623, 927.1840780113499, 938.4744543055893, 940.5438362394237, 954.0697819625864, 18864.434066977996, 19670.213191472343, 19678.901605491952, 19735.901320493394, 19770.308039218595, 17925.372611958584, 18008.4597462076, 18017.81982180178, 18448.538786530342, 22492.325230243077, 1034.1571619130423, 1045.9529321180528, 1046.7697106636529, 1055.0346433013783, 1057.0592172966067, 1069.7699994501181, 1072.2922870905204, 1078.202130423485, 1078.757279612089, 1080.3409919948824, 769.29225112896, 793.0998316910319, 1061.8566493523392, 1114.4316398636713, 1131.0, 1090.3076546393017, 1121.7980763462574, 1122.3097794856187, 1123.4495097402255, 1123.719070232442, 817.2481317188201, 819.4714409206028, 824.5712229640553, 824.5959479854888, 825.7192554531429, 19921.203151873906, 20443.693344599844, 20558.897205514026, 20562.28032018872, 20784.168633254652, 21817.563648726937, 22230.666540001912, 22318.33045008636, 22452.43868903274, 22611.660825087638, 16972.660546788997, 17172.914135429244, 17207.225674844663, 17220.311187552485, 18099.095045247817, 3720.813959302024, 3722.5160729105314, 3737.289914916157, 3738.6261373862667, 3739.046543131511, 119927.4003629985, 121667.78332216654, 129471.35264323713, 130377.0, 131476.34261828725, 17395.826041739674, 18139.637207255782, 18183.636327273645, 18213.817861821477, 18315.725264121047, 31374.686253137632, 31428.52857207144, 31745.20636984094, 32199.51700724444, 32234.0, 8838.027816940132, 8939.061398553189, 8974.551272436353, 9006.189442950166, 9023.503707296162, 4028.9798551007643, 4070.6946978976694, 4126.277901367249, 4126.66986641068, 4150.27370210212, 5402.8919421611345, 5515.558755299647, 5530.668159910419, 5541.861453463695, 5547.7780888764, 957.9712608621752, 1088.2110469909253, 1088.3959402531514, 1110.0, 1119.7088756923097, 657.947364210862, 676.2594958520413, 683.7572661705024, 690.9481788865754, 700.5691499727631, 11312.0, 11623.59317423886, 11935.641930742091, 12804.93597532025, 13536.526221582395, 636.9872602547923, 678.8438659108433, 688.3323176518769, 695.4610177112677, 697.8953157026486, 5600.915986260209, 6258.092576576371, 6507.7071531781185, 6536.869262614816, 6589.538732288694, 104515.4774226124, 110004.0, 110266.0, 110321.0, 112048.0, 94625.5268723652, 95622.0, 97258.0, 97866.5106674462, 98632.50683746535, 84065.77488286674, 85413.57293213494, 88263.0, 89254.0, 89325.10674893297, 12921.741565168832, 13467.730645387233, 13526.18842869431, 13593.932030339785, 13630.795538067136, 40939.38590921198, 41313.79343103265, 41829.0, 42512.362314564685, 43215.56784432241, 54950.72524637351, 55399.0, 56153.0, 56650.150247747144, 57175.0, 17701.645967080844, 17734.822651773833, 17976.82023179804, 18221.180046898186, 18372.81627183711, 20342.288019919233, 20417.591648166657, 20499.692504612143, 20634.793652063887, 20744.68882966787, 19166.329178478685, 19174.233030678617, 19213.23147074157, 19295.51761205981, 19344.129514171615, 18190.09049547491, 18363.54091147732, 18389.632207356044, 18398.724019139456, 18428.078596070412, 18563.81436185675, 18623.81376186275, 18654.906725466284, 18729.15718792685, 19084.713729293795, 13939.303034848419, 14036.29818509091, 14253.216073115664, 14287.57137285883, 14612.78080828767, 14170.858291417366, 14437.422503099759, 14923.477678281643, 15119.0, 15295.311710973256], "value": 9345.322978359874, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1565.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 116.0, 100.0, 108.0, 117.0, 111.0, 111.0, 100.0, 117.0, 111.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 119.0, 147.0, 192.0, 118.0, 149.0, 147.0, 128.0, 182.0, 121.0], "value": 145.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 169.0, 164.0, 163.0, 181.0, 175.0, 164.0, 166.0, 165.0], "value": 167.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 178.0, 77.0, 82.0, 81.0, 90.0, 102.0, 82.0], "value": 91.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 90.0, 129.0, 79.0, 88.0, 78.0, 139.0, 82.0, 80.0, 137.0], "value": 98.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 125.0, 115.0, 115.0, 115.0, 122.0, 118.0, 123.0, 124.0, 124.0], "value": 120.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 150.0, 151.0, 153.0, 161.0, 158.0, 151.0, 151.0, 157.0, 156.0], "value": 154.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 96.0, 98.0, 94.0, 95.0, 96.0, 94.0, 101.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 56.0, 55.0, 57.0, 54.0, 55.0, 55.0, 55.0, 55.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 61.0, 58.0, 62.0, 62.0, 60.0, 65.0, 55.0, 55.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 80.0, 84.0, 78.0, 77.0, 87.0, 78.0, 81.0, 84.0, 79.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 123.0, 131.0, 129.0, 154.0, 121.0, 136.0, 129.0, 133.0, 165.0], "value": 135.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 185.0, 186.0, 179.0, 181.0, 177.0, 175.0, 188.0, 180.0, 178.0], "value": 181.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 68.0, 71.0, 71.0, 73.0, 68.0, 67.0, 75.0, 66.0], "value": 70.2, "unit": "score"}]}]} 15:38:32 INFO - Return code: 0 15:38:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:38:32 INFO - # TBPL SUCCESS # 15:38:32 INFO - Running post-action listener: _package_coverage_data 15:38:32 INFO - Running post-action listener: _resource_record_post_action 15:38:32 INFO - [mozharness: 2017-08-20 22:38:32.732114Z] Finished run-tests step (success) 15:38:32 INFO - Running post-run listener: _resource_record_post_run 15:38:32 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 90112; Write bytes: 435630080; Read time: 260; Write time: 263180 15:38:32 INFO - TinderboxPrint: CPU usage
13.3% 15:38:32 INFO - TinderboxPrint: I/O read bytes / time
90,112 / 260 15:38:32 INFO - TinderboxPrint: I/O write bytes / time
435,630,080 / 263,180 15:38:32 INFO - TinderboxPrint: CPU idle
8,270.9 (86.7%) 15:38:32 INFO - TinderboxPrint: CPU user
1,207.8 (12.7%) 15:38:32 INFO - TinderboxPrint: Swap in / out
0 / 0 15:38:32 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107282432; Read time: 0; Write time: 90872 15:38:32 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 15:38:32 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 86016; Write bytes: 328347648; Read time: 248; Write time: 172308 15:38:33 INFO - Running post-run listener: _upload_blobber_files 15:38:33 INFO - Blob upload gear active. 15:38:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:38:33 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 15:38:33 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:38:33 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:38:33 INFO - (blobuploader) - INFO - Open directory for files ... 15:38:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:38:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:38:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:38:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:38:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:38:34 INFO - (blobuploader) - INFO - Done attempting. 15:38:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:38:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:38:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:38:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:38:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:38:37 INFO - (blobuploader) - INFO - Done attempting. 15:38:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:38:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:38:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:38:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:38:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:38:38 INFO - (blobuploader) - INFO - Done attempting. 15:38:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:38:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:38:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:38:39 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:38:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:38:39 INFO - (blobuploader) - INFO - Done attempting. 15:38:39 INFO - (blobuploader) - INFO - Iteration through files over. 15:38:39 INFO - Return code: 0 15:38:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:38:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:38:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f0140d0e292848f74661d26629303361ec2a2058a0733f821c1ae4f296c522bfca30a59915c2019521bc635127b27994e3f4d81a0a0c40fccdcc55a8f5dcd66", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3a9dcfa175ed1330c42f7012a96c0732e8420d9fb8761181a5486211f3e2701c89e0f148030ee9283602b14ef61468686edac7ffcfabce509245e94dfe60e9ec", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad8617b030386069ffc0be13d444a90d4b04080e84235af28ea79ac133d59ead84c71fe5acf8fedee58df8d63225547653527c5403387df80f32dee867f652d9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1efca3878d5d1e5e618daad06c197c513bae9d96a8d13058f48b0cf6600e6c477340327e9d66fa0f57783d761740f79f6f0ad9b556d2e8f2a5e0830385e898ee"} 15:38:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:38:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:38:39 INFO - Contents: 15:38:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f0140d0e292848f74661d26629303361ec2a2058a0733f821c1ae4f296c522bfca30a59915c2019521bc635127b27994e3f4d81a0a0c40fccdcc55a8f5dcd66", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3a9dcfa175ed1330c42f7012a96c0732e8420d9fb8761181a5486211f3e2701c89e0f148030ee9283602b14ef61468686edac7ffcfabce509245e94dfe60e9ec", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad8617b030386069ffc0be13d444a90d4b04080e84235af28ea79ac133d59ead84c71fe5acf8fedee58df8d63225547653527c5403387df80f32dee867f652d9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1efca3878d5d1e5e618daad06c197c513bae9d96a8d13058f48b0cf6600e6c477340327e9d66fa0f57783d761740f79f6f0ad9b556d2e8f2a5e0830385e898ee"} 15:38:39 INFO - Running post-run listener: copy_logs_to_upload_dir 15:38:39 INFO - Copying logs to upload dir... 15:38:39 INFO - mkdir: /builds/slave/test/build/upload/logs 15:38:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.649591 ========= master_lag: -0.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-08-20 15:38:39.075677) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-20 15:38:39.079724) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1503266609.579673-355119672 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f0140d0e292848f74661d26629303361ec2a2058a0733f821c1ae4f296c522bfca30a59915c2019521bc635127b27994e3f4d81a0a0c40fccdcc55a8f5dcd66", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3a9dcfa175ed1330c42f7012a96c0732e8420d9fb8761181a5486211f3e2701c89e0f148030ee9283602b14ef61468686edac7ffcfabce509245e94dfe60e9ec", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad8617b030386069ffc0be13d444a90d4b04080e84235af28ea79ac133d59ead84c71fe5acf8fedee58df8d63225547653527c5403387df80f32dee867f652d9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1efca3878d5d1e5e618daad06c197c513bae9d96a8d13058f48b0cf6600e6c477340327e9d66fa0f57783d761740f79f6f0ad9b556d2e8f2a5e0830385e898ee"} build_url:https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011244 build_url: 'https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f0140d0e292848f74661d26629303361ec2a2058a0733f821c1ae4f296c522bfca30a59915c2019521bc635127b27994e3f4d81a0a0c40fccdcc55a8f5dcd66", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3a9dcfa175ed1330c42f7012a96c0732e8420d9fb8761181a5486211f3e2701c89e0f148030ee9283602b14ef61468686edac7ffcfabce509245e94dfe60e9ec", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad8617b030386069ffc0be13d444a90d4b04080e84235af28ea79ac133d59ead84c71fe5acf8fedee58df8d63225547653527c5403387df80f32dee867f652d9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1efca3878d5d1e5e618daad06c197c513bae9d96a8d13058f48b0cf6600e6c477340327e9d66fa0f57783d761740f79f6f0ad9b556d2e8f2a5e0830385e898ee"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-20 15:38:39.106046) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 15:38:39.110404) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1503266609.579673-355119672 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004497 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 15:38:39.188243) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-20 15:38:39.190084) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-20 15:38:39.190384) ========= ========= Total master_lag: 0.05 =========