builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-040 starttime: 1506002607.38 results: success (0) revision: 9caeafcec9982be90820e30bc699e851cb6af907 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-21 07:03:27.381916) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-21 07:03:27.382388) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-21 07:03:27.382752) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-21 07:03:27.426140) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 07:03:27.426521) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1506002182.263489-733130944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-21 07:03:27-- 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% 223M=0s 2017-09-21 07:03:27 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126272 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 07:03:27.568300) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 07:03:27.571675) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1506002182.263489-733130944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019531 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 07:03:27.630224) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-09-21 07:03:27.630545) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9caeafcec9982be90820e30bc699e851cb6af907 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 9caeafcec9982be90820e30bc699e851cb6af907 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9e0dfe3369c33a1556e63f89000001d8-1506002182.263489-733130944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-21 07:03:27,998 truncating revision to first 12 chars 2017-09-21 07:03:27,998 Setting DEBUG logging. 2017-09-21 07:03:27,998 attempt 1/10 2017-09-21 07:03:27,998 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9caeafcec998?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-21 07:03:28,528 attempt 1/10 2017-09-21 07:03:29,093 current task status: no status available at this point. state: STARTED 2017-09-21 07:03:29,093 sleeping for 9.00s (attempt 1/10) 2017-09-21 07:03:38,102 attempt 2/10 2017-09-21 07:03:38,495 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-09-21 07:03:38,677 unpacking tar archive at: mozilla-central-9caeafcec998/testing/mozharness/ program finished with exit code 0 elapsedTime=10.992894 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-09-21 07:03:38.639617) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-21 07:03:38.642943) ========= script_repo_revision: 9caeafcec9982be90820e30bc699e851cb6af907 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-21 07:03:38.643325) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-21 07:03:38.643578) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-21 07:03:38.657044) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-09-21 07:03:38.657436) ========= /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=9e0dfe3369c33a1556e63f89000001d8-1506002182.263489-733130944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:03:39 INFO - MultiFileLogger online at 20170921 07:03:39 in /builds/slave/test 07:03:39 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 07:03:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:03:39 INFO - {'append_to_log': False, 07:03:39 INFO - 'base_work_dir': '/builds/slave/test', 07:03:39 INFO - 'blob_upload_branch': 'Firefox', 07:03:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:03:39 INFO - 'branch': 'Firefox', 07:03:39 INFO - 'buildbot_json_path': 'buildprops.json', 07:03:39 INFO - 'code_coverage': False, 07:03:39 INFO - 'config_files': ('talos/linux_config.py',), 07:03:39 INFO - 'default_actions': ('clobber', 07:03:39 INFO - 'read-buildbot-config', 07:03:39 INFO - 'download-and-extract', 07:03:39 INFO - 'populate-webroot', 07:03:39 INFO - 'create-virtualenv', 07:03:39 INFO - 'install', 07:03:39 INFO - 'setup-mitmproxy', 07:03:39 INFO - 'run-tests'), 07:03:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:03:39 INFO - 'disable_ccov_upload': False, 07:03:39 INFO - 'disable_stylo': False, 07:03:39 INFO - 'download_minidump_stackwalk': True, 07:03:39 INFO - 'download_symbols': 'ondemand', 07:03:39 INFO - 'enable_stylo': False, 07:03:39 INFO - 'enable_webrender': False, 07:03:39 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 07:03:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:03:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:03:39 INFO - 'gecko_profile': False, 07:03:39 INFO - 'gecko_profile_interval': 0, 07:03:39 INFO - 'installer_path': 'installer.exe', 07:03:39 INFO - 'log_level': 'info', 07:03:39 INFO - 'log_name': 'talos', 07:03:39 INFO - 'log_to_console': True, 07:03:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:03:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:03:39 INFO - 'opt_config_files': (), 07:03:39 INFO - 'pip_index': False, 07:03:39 INFO - 'suite': 'dromaeojs-e10s', 07:03:39 INFO - 'system_bits': '32', 07:03:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:03:39 INFO - 'title': 'talos-linux64-ix-040', 07:03:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:03:39 INFO - 'use_talos_json': True, 07:03:39 INFO - 'verify': 'False', 07:03:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:03:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:03:39 INFO - 'work_dir': 'build'} 07:03:39 INFO - [mozharness: 2017-09-21 14:03:39.175797Z] Running clobber step. 07:03:39 INFO - Running pre-action listener: _resource_record_pre_action 07:03:39 INFO - Running main action method: clobber 07:03:39 INFO - rmtree: /builds/slave/test/build 07:03:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:03:40 INFO - Running post-action listener: _resource_record_post_action 07:03:40 INFO - [mozharness: 2017-09-21 14:03:40.174335Z] Finished clobber step (success) 07:03:40 INFO - [mozharness: 2017-09-21 14:03:40.174433Z] Running read-buildbot-config step. 07:03:40 INFO - Running pre-action listener: _resource_record_pre_action 07:03:40 INFO - Running main action method: read_buildbot_config 07:03:40 INFO - Using buildbot properties: 07:03:40 INFO - { 07:03:40 INFO - "project": "", 07:03:40 INFO - "product": "firefox", 07:03:40 INFO - "who": "archaeopteryx@coole-files.de", 07:03:40 INFO - "installer_path": "public/build/target.tar.bz2", 07:03:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 07:03:40 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 07:03:40 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 07:03:40 INFO - "stage_platform": "linux64-qr", 07:03:40 INFO - "basedir": "/builds/slave/test", 07:03:40 INFO - "buildnumber": 87, 07:03:40 INFO - "platform": "ubuntu64_hw_qr", 07:03:40 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:03:40 INFO - "slavebuilddir": "test", 07:03:40 INFO - "taskId": "SKGdH6-tQBW_reapoH2wmA", 07:03:40 INFO - "branch": "mozilla-central", 07:03:40 INFO - "script_repo_revision": "production", 07:03:40 INFO - "revision": "9caeafcec9982be90820e30bc699e851cb6af907", 07:03:40 INFO - "slavename": "talos-linux64-ix-040", 07:03:40 INFO - "repo_path": "mozilla-central" 07:03:40 INFO - } 07:03:40 INFO - Finding installer, test and symbols from parent task. 07:03:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SKGdH6-tQBW_reapoH2wmA'}, attempt #1 07:03:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SKGdH6-tQBW_reapoH2wmA'}, attempt #1 07:03:41 INFO - Task dependencies: OR_WzdNeS6ee0KU9V4iMiw 07:03:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OR_WzdNeS6ee0KU9V4iMiw'}, attempt #1 07:03:42 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/OR_WzdNeS6ee0KU9V4iMiw/artifacts/public/build/target.tar.bz2 07:03:42 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/OR_WzdNeS6ee0KU9V4iMiw/artifacts/public/build/target.test_packages.json 07:03:42 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/OR_WzdNeS6ee0KU9V4iMiw/artifacts/public/build/target.crashreporter-symbols.zip 07:03:42 INFO - Running post-action listener: _resource_record_post_action 07:03:42 INFO - [mozharness: 2017-09-21 14:03:42.313736Z] Finished read-buildbot-config step (success) 07:03:42 INFO - [mozharness: 2017-09-21 14:03:42.313953Z] Running download-and-extract step. 07:03:42 INFO - Running pre-action listener: _resource_record_pre_action 07:03:42 INFO - Running main action method: download_and_extract 07:03:42 INFO - mkdir: /builds/slave/test/build/tests 07:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:03:42 INFO - trying https://queue.taskcluster.net/v1/task/OR_WzdNeS6ee0KU9V4iMiw/artifacts/public/build/target.test_packages.json 07:03:42 INFO - Downloading https://queue.taskcluster.net/v1/task/OR_WzdNeS6ee0KU9V4iMiw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:03:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OR_WzdNeS6ee0KU9V4iMiw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:03:42 INFO - Downloaded 989 bytes. 07:03:42 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:03:42 INFO - Using the following test package requirements: 07:03:42 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 07:03:42 INFO - u'common': [u'target.common.tests.zip'], 07:03:42 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:03:42 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:03:42 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:03:42 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:03:42 INFO - u'mozbase': [u'target.common.tests.zip'], 07:03:42 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:03:42 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:03:42 INFO - u'web-platform': [u'target.common.tests.zip', 07:03:42 INFO - u'target.web-platform.tests.tar.gz'], 07:03:42 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:03:42 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 07:03:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OR_WzdNeS6ee0KU9V4iMiw/artifacts/public/build/target.common.tests.zip 07:03:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OR_WzdNeS6ee0KU9V4iMiw/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:03:42 INFO - Fetch https://queue.taskcluster.net/v1/task/OR_WzdNeS6ee0KU9V4iMiw/artifacts/public/build/target.common.tests.zip into memory 07:03:44 INFO - Content-Length response header: 54741119 07:03:44 INFO - Bytes received: 54741119 07:03:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OR_WzdNeS6ee0KU9V4iMiw/artifacts/public/build/target.talos.tests.zip 07:03:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OR_WzdNeS6ee0KU9V4iMiw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:03:55 INFO - Fetch https://queue.taskcluster.net/v1/task/OR_WzdNeS6ee0KU9V4iMiw/artifacts/public/build/target.talos.tests.zip into memory 07:03:55 INFO - Content-Length response header: 14509184 07:03:55 INFO - Bytes received: 14509184 07:03:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:03:56 INFO - trying https://queue.taskcluster.net/v1/task/OR_WzdNeS6ee0KU9V4iMiw/artifacts/public/build/target.tar.bz2 07:03:56 INFO - Downloading https://queue.taskcluster.net/v1/task/OR_WzdNeS6ee0KU9V4iMiw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:03:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OR_WzdNeS6ee0KU9V4iMiw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:03:57 INFO - Downloaded 61692717 bytes. 07:03:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OR_WzdNeS6ee0KU9V4iMiw/artifacts/public/build/target.tar.bz2 07:03:57 INFO - mkdir: /builds/slave/test/properties 07:03:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:03:57 INFO - Writing to file /builds/slave/test/properties/build_url 07:03:57 INFO - Contents: 07:03:57 INFO - build_url:https://queue.taskcluster.net/v1/task/OR_WzdNeS6ee0KU9V4iMiw/artifacts/public/build/target.tar.bz2 07:03:57 INFO - Running post-action listener: _resource_record_post_action 07:03:57 INFO - Running post-action listener: find_tests_for_verification 07:03:57 INFO - Running post-action listener: set_extra_try_arguments 07:03:57 INFO - [mozharness: 2017-09-21 14:03:57.789411Z] Finished download-and-extract step (success) 07:03:57 INFO - [mozharness: 2017-09-21 14:03:57.789638Z] Running populate-webroot step. 07:03:57 INFO - Running pre-action listener: _resource_record_pre_action 07:03:57 INFO - Running main action method: populate_webroot 07:03:57 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:03:57 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:03:57 INFO - 'tests': ['tresize', 07:03:57 INFO - 'tcanvasmark']}, 07:03:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:03:57 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:03:57 INFO - 'tests': ['dromaeo_css', 07:03:57 INFO - 'kraken']}, 07:03:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:03:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:03:57 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:03:57 INFO - 'talos_options': ['--disable-stylo'], 07:03:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:03:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:03:57 INFO - 'tests': ['damp', 'tps']}, 07:03:57 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:03:57 INFO - 'talos_options': ['--disable-stylo'], 07:03:57 INFO - 'tests': ['damp', 'tps']}, 07:03:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:03:57 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:03:57 INFO - 'tests': ['dromaeo_dom']}, 07:03:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 07:03:57 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:03:57 INFO - 'tests': ['basic_compositor_video', 07:03:57 INFO - 'glvideo']}, 07:03:57 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 07:03:57 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 07:03:57 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:03:57 INFO - 'talos_options': ['--disable-stylo'], 07:03:57 INFO - 'tests': ['ts_paint_webext', 07:03:57 INFO - 'tp5o_webext']}, 07:03:57 INFO - 'other-e10s': {'tests': ['a11yr', 07:03:57 INFO - 'ts_paint', 07:03:57 INFO - 'tpaint', 07:03:57 INFO - 'sessionrestore', 07:03:57 INFO - 'sessionrestore_many_windows', 07:03:57 INFO - 'sessionrestore_no_auto_restore', 07:03:57 INFO - 'tabpaint']}, 07:03:57 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:03:57 INFO - 'tests': ['a11yr', 07:03:57 INFO - 'ts_paint', 07:03:57 INFO - 'tpaint', 07:03:57 INFO - 'sessionrestore', 07:03:57 INFO - 'sessionrestore_many_windows', 07:03:57 INFO - 'sessionrestore_no_auto_restore', 07:03:57 INFO - 'tabpaint']}, 07:03:57 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 07:03:57 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 07:03:57 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:03:57 INFO - 'tests': ['perf_reftest_singletons']}, 07:03:57 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:03:57 INFO - 'tests': ['bloom_basic']}, 07:03:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:03:57 INFO - 'tsvgr_opacity', 07:03:57 INFO - 'tart', 07:03:57 INFO - 'tscrollx', 07:03:57 INFO - 'tsvg_static']}, 07:03:57 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:03:57 INFO - 'tests': ['tsvgx', 07:03:57 INFO - 'tsvgr_opacity', 07:03:57 INFO - 'tart', 07:03:57 INFO - 'tscrollx', 07:03:57 INFO - 'tsvg_static']}, 07:03:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:03:57 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:03:57 INFO - 'talos_options': ['--disable-stylo'], 07:03:57 INFO - 'tests': ['tp5o']}, 07:03:57 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:03:57 INFO - 'talos_options': ['--mitmproxy', 07:03:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:03:57 INFO - '--firstNonBlankPaint'], 07:03:57 INFO - 'tests': ['tp6_google', 07:03:57 INFO - 'tp6_youtube', 07:03:57 INFO - 'tp6_amazon', 07:03:57 INFO - 'tp6_facebook']}, 07:03:57 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:03:57 INFO - 'talos_options': ['--disable-stylo', 07:03:57 INFO - '--mitmproxy', 07:03:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:03:57 INFO - '--firstNonBlankPaint'], 07:03:57 INFO - 'tests': ['tp6_google', 07:03:57 INFO - 'tp6_youtube', 07:03:57 INFO - 'tp6_amazon', 07:03:57 INFO - 'tp6_facebook']}, 07:03:57 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:03:57 INFO - 'talos_options': ['--stylo-threads=1', 07:03:57 INFO - '--mitmproxy', 07:03:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:03:57 INFO - '--firstNonBlankPaint'], 07:03:57 INFO - 'tests': ['tp6_google', 07:03:57 INFO - 'tp6_youtube', 07:03:57 INFO - 'tp6_amazon', 07:03:57 INFO - 'tp6_facebook']}, 07:03:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:03:57 INFO - 'talos_options': ['--xperf_path', 07:03:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:03:57 INFO - 'tests': ['tp5n']}, 07:03:57 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:03:57 INFO - 'talos_options': ['--disable-stylo', 07:03:57 INFO - '--xperf_path', 07:03:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:03:57 INFO - 'tests': ['tp5n']}}} 07:03:57 INFO - Running post-action listener: _resource_record_post_action 07:03:57 INFO - [mozharness: 2017-09-21 14:03:57.808412Z] Finished populate-webroot step (success) 07:03:57 INFO - [mozharness: 2017-09-21 14:03:57.808502Z] Running create-virtualenv step. 07:03:57 INFO - Running pre-action listener: _resource_record_pre_action 07:03:57 INFO - Running main action method: create_virtualenv 07:03:57 INFO - Creating virtualenv /builds/slave/test/build/venv 07:03:57 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:03:57 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 07:03:57 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 07:03:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:03:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:03:58 INFO - Installing distribute.............................................................................................................................................................................................done. 07:03:58 INFO - Installing pip...............done. 07:03:58 INFO - Return code: 0 07:03:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:03:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:03:58 INFO - Reading from file tmpfile_stdout 07:03:58 INFO - Output received: 07:03:58 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 07:03:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:03:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:03:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2563a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2706a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270a090>, '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 0x270ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2704f90>, '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': '9e0dfe3369c33a1556e63f89000001d8-1506002182.263489-733130944', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:03:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:03:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:03:58 INFO - Using env: {'DISPLAY': ':0', 07:03:58 INFO - 'HOME': '/home/cltbld', 07:03:58 INFO - 'LANG': 'en_US.UTF-8', 07:03:58 INFO - 'LANGUAGE': 'en_US:en', 07:03:58 INFO - 'LOGNAME': 'cltbld', 07:03:58 INFO - 'MAIL': '/var/mail/cltbld', 07:03:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:58 INFO - 'MOZ_NO_REMOTE': '1', 07:03:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:58 INFO - 'NO_EM_RESTART': '1', 07:03:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:58 INFO - 'PWD': '/builds/slave/test', 07:03:58 INFO - 'SHELL': '/bin/bash', 07:03:58 INFO - 'SHLVL': '1', 07:03:58 INFO - 'TERM': 'linux', 07:03:58 INFO - 'TMOUT': '86400', 07:03:58 INFO - 'USER': 'cltbld', 07:03:58 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506002182.263489-733130944', 07:03:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:58 INFO - '_': '/tools/buildbot/bin/python'} 07:04:00 INFO - Ignoring indexes: http://pypi.python.org/simple/ 07:04:00 INFO - Downloading/unpacking pip>=1.5 07:04:00 INFO - Running setup.py egg_info for package pip 07:04:00 INFO - warning: no files found matching 'pip/cacert.pem' 07:04:00 INFO - warning: no files found matching '*.html' under directory 'docs' 07:04:00 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 07:04:00 INFO - no previously-included directories found matching 'docs/_build/_sources' 07:04:00 INFO - Installing collected packages: pip 07:04:00 INFO - Found existing installation: pip 1.1 07:04:00 INFO - Uninstalling pip: 07:04:00 INFO - Successfully uninstalled pip 07:04:00 INFO - Running setup.py install for pip 07:04:00 INFO - warning: no files found matching 'pip/cacert.pem' 07:04:00 INFO - warning: no files found matching '*.html' under directory 'docs' 07:04:00 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 07:04:00 INFO - no previously-included directories found matching 'docs/_build/_sources' 07:04:00 INFO - Installing pip script to /builds/slave/test/build/venv/bin 07:04:00 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 07:04:00 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 07:04:00 INFO - Successfully installed pip 07:04:00 INFO - Cleaning up... 07:04:00 INFO - Return code: 0 07:04:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:04:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x239a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2563a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2706a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270a090>, '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 0x270ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2704f90>, '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': '9e0dfe3369c33a1556e63f89000001d8-1506002182.263489-733130944', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:04:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:04:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:04:00 INFO - Using env: {'DISPLAY': ':0', 07:04:00 INFO - 'HOME': '/home/cltbld', 07:04:00 INFO - 'LANG': 'en_US.UTF-8', 07:04:00 INFO - 'LANGUAGE': 'en_US:en', 07:04:00 INFO - 'LOGNAME': 'cltbld', 07:04:00 INFO - 'MAIL': '/var/mail/cltbld', 07:04:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:00 INFO - 'MOZ_NO_REMOTE': '1', 07:04:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:00 INFO - 'NO_EM_RESTART': '1', 07:04:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:00 INFO - 'PWD': '/builds/slave/test', 07:04:00 INFO - 'SHELL': '/bin/bash', 07:04:00 INFO - 'SHLVL': '1', 07:04:00 INFO - 'TERM': 'linux', 07:04:00 INFO - 'TMOUT': '86400', 07:04:00 INFO - 'USER': 'cltbld', 07:04:00 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506002182.263489-733130944', 07:04:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:00 INFO - '_': '/tools/buildbot/bin/python'} 07:04:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:00 INFO - Downloading/unpacking psutil>=3.1.1 07:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:04:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:04:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:04:02 INFO - Installing collected packages: psutil 07:04:02 INFO - Running setup.py install for psutil 07:04:02 INFO - building 'psutil._psutil_linux' extension 07:04:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:04:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:04:02 INFO - building 'psutil._psutil_posix' extension 07:04:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:04:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:04:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:04:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:04:03 INFO - Successfully installed psutil 07:04:03 INFO - Cleaning up... 07:04:03 INFO - Return code: 0 07:04:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:04:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2563a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2706a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270a090>, '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 0x270ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2704f90>, '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': '9e0dfe3369c33a1556e63f89000001d8-1506002182.263489-733130944', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:04:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:04:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:04:03 INFO - Using env: {'DISPLAY': ':0', 07:04:03 INFO - 'HOME': '/home/cltbld', 07:04:03 INFO - 'LANG': 'en_US.UTF-8', 07:04:03 INFO - 'LANGUAGE': 'en_US:en', 07:04:03 INFO - 'LOGNAME': 'cltbld', 07:04:03 INFO - 'MAIL': '/var/mail/cltbld', 07:04:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:03 INFO - 'MOZ_NO_REMOTE': '1', 07:04:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:03 INFO - 'NO_EM_RESTART': '1', 07:04:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:03 INFO - 'PWD': '/builds/slave/test', 07:04:03 INFO - 'SHELL': '/bin/bash', 07:04:03 INFO - 'SHLVL': '1', 07:04:03 INFO - 'TERM': 'linux', 07:04:03 INFO - 'TMOUT': '86400', 07:04:03 INFO - 'USER': 'cltbld', 07:04:03 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506002182.263489-733130944', 07:04:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:03 INFO - '_': '/tools/buildbot/bin/python'} 07:04:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:04:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:04:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:04:04 INFO - Installing collected packages: mozsystemmonitor 07:04:04 INFO - Running setup.py install for mozsystemmonitor 07:04:04 INFO - Successfully installed mozsystemmonitor 07:04:04 INFO - Cleaning up... 07:04:05 INFO - Return code: 0 07:04:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:04:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x239a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2563a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2706a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270a090>, '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 0x270ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2704f90>, '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': '9e0dfe3369c33a1556e63f89000001d8-1506002182.263489-733130944', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:04:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:04:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:04:05 INFO - Using env: {'DISPLAY': ':0', 07:04:05 INFO - 'HOME': '/home/cltbld', 07:04:05 INFO - 'LANG': 'en_US.UTF-8', 07:04:05 INFO - 'LANGUAGE': 'en_US:en', 07:04:05 INFO - 'LOGNAME': 'cltbld', 07:04:05 INFO - 'MAIL': '/var/mail/cltbld', 07:04:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:05 INFO - 'MOZ_NO_REMOTE': '1', 07:04:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:05 INFO - 'NO_EM_RESTART': '1', 07:04:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:05 INFO - 'PWD': '/builds/slave/test', 07:04:05 INFO - 'SHELL': '/bin/bash', 07:04:05 INFO - 'SHLVL': '1', 07:04:05 INFO - 'TERM': 'linux', 07:04:05 INFO - 'TMOUT': '86400', 07:04:05 INFO - 'USER': 'cltbld', 07:04:05 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506002182.263489-733130944', 07:04:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:05 INFO - '_': '/tools/buildbot/bin/python'} 07:04:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:05 INFO - Downloading/unpacking jsonschema==2.5.1 07:04:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:04:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:04:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:07 INFO - Downloading functools32-3.2.3-2.tar.gz 07:04:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:04:07 INFO - warning: no files found matching '*.txt' 07:04:07 INFO - no previously-included directories found matching 'build' 07:04:07 INFO - no previously-included directories found matching 'dist' 07:04:07 INFO - no previously-included directories found matching '.git*' 07:04:07 INFO - Installing collected packages: jsonschema, functools32 07:04:07 INFO - Running setup.py install for functools32 07:04:07 INFO - warning: no files found matching '*.txt' 07:04:07 INFO - no previously-included directories found matching 'build' 07:04:07 INFO - no previously-included directories found matching 'dist' 07:04:07 INFO - no previously-included directories found matching '.git*' 07:04:07 INFO - Successfully installed jsonschema functools32 07:04:07 INFO - Cleaning up... 07:04:07 INFO - Return code: 0 07:04:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:04:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x239a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2563a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2706a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270a090>, '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 0x270ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2704f90>, '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': '9e0dfe3369c33a1556e63f89000001d8-1506002182.263489-733130944', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:04:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:04:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:04:07 INFO - Using env: {'DISPLAY': ':0', 07:04:07 INFO - 'HOME': '/home/cltbld', 07:04:07 INFO - 'LANG': 'en_US.UTF-8', 07:04:07 INFO - 'LANGUAGE': 'en_US:en', 07:04:07 INFO - 'LOGNAME': 'cltbld', 07:04:07 INFO - 'MAIL': '/var/mail/cltbld', 07:04:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:07 INFO - 'MOZ_NO_REMOTE': '1', 07:04:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:07 INFO - 'NO_EM_RESTART': '1', 07:04:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:07 INFO - 'PWD': '/builds/slave/test', 07:04:07 INFO - 'SHELL': '/bin/bash', 07:04:07 INFO - 'SHLVL': '1', 07:04:07 INFO - 'TERM': 'linux', 07:04:07 INFO - 'TMOUT': '86400', 07:04:07 INFO - 'USER': 'cltbld', 07:04:07 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506002182.263489-733130944', 07:04:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:07 INFO - '_': '/tools/buildbot/bin/python'} 07:04:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:04:07 INFO - Cleaning up... 07:04:07 INFO - Return code: 0 07:04:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:04:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x239a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2563a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2706a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270a090>, '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 0x270ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2704f90>, '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': '9e0dfe3369c33a1556e63f89000001d8-1506002182.263489-733130944', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:04:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:04:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:04:07 INFO - Using env: {'DISPLAY': ':0', 07:04:07 INFO - 'HOME': '/home/cltbld', 07:04:07 INFO - 'LANG': 'en_US.UTF-8', 07:04:07 INFO - 'LANGUAGE': 'en_US:en', 07:04:07 INFO - 'LOGNAME': 'cltbld', 07:04:07 INFO - 'MAIL': '/var/mail/cltbld', 07:04:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:07 INFO - 'MOZ_NO_REMOTE': '1', 07:04:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:07 INFO - 'NO_EM_RESTART': '1', 07:04:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:07 INFO - 'PWD': '/builds/slave/test', 07:04:07 INFO - 'SHELL': '/bin/bash', 07:04:07 INFO - 'SHLVL': '1', 07:04:07 INFO - 'TERM': 'linux', 07:04:07 INFO - 'TMOUT': '86400', 07:04:07 INFO - 'USER': 'cltbld', 07:04:07 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506002182.263489-733130944', 07:04:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:07 INFO - '_': '/tools/buildbot/bin/python'} 07:04:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:08 INFO - Downloading/unpacking blobuploader==1.2.4 07:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:09 INFO - Downloading blobuploader-1.2.4.tar.gz 07:04:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:04:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:04:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:04:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:04:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:09 INFO - Downloading docopt-0.6.1.tar.gz 07:04:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:04:09 INFO - Installing collected packages: blobuploader, requests, docopt 07:04:09 INFO - Running setup.py install for blobuploader 07:04:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:04:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:04:09 INFO - Running setup.py install for requests 07:04:10 INFO - Running setup.py install for docopt 07:04:10 INFO - Successfully installed blobuploader requests docopt 07:04:10 INFO - Cleaning up... 07:04:10 INFO - Return code: 0 07:04:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:04:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:10 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 0x239a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2563a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2706a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270a090>, '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 0x270ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2704f90>, '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': '9e0dfe3369c33a1556e63f89000001d8-1506002182.263489-733130944', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:04:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:04:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:04:10 INFO - Using env: {'DISPLAY': ':0', 07:04:10 INFO - 'HOME': '/home/cltbld', 07:04:10 INFO - 'LANG': 'en_US.UTF-8', 07:04:10 INFO - 'LANGUAGE': 'en_US:en', 07:04:10 INFO - 'LOGNAME': 'cltbld', 07:04:10 INFO - 'MAIL': '/var/mail/cltbld', 07:04:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:10 INFO - 'MOZ_NO_REMOTE': '1', 07:04:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:10 INFO - 'NO_EM_RESTART': '1', 07:04:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:10 INFO - 'PWD': '/builds/slave/test', 07:04:10 INFO - 'SHELL': '/bin/bash', 07:04:10 INFO - 'SHLVL': '1', 07:04:10 INFO - 'TERM': 'linux', 07:04:10 INFO - 'TMOUT': '86400', 07:04:10 INFO - 'USER': 'cltbld', 07:04:10 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506002182.263489-733130944', 07:04:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:10 INFO - '_': '/tools/buildbot/bin/python'} 07:04:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:04:10 INFO - Running setup.py (path:/tmp/pip-QMla2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:04:10 INFO - Running setup.py (path:/tmp/pip-m1nDOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:04:10 INFO - Running setup.py (path:/tmp/pip-QScPf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:04:10 INFO - Running setup.py (path:/tmp/pip-tnprbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:04:10 INFO - Running setup.py (path:/tmp/pip-MpYhvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:04:10 INFO - Running setup.py (path:/tmp/pip-QX_VIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:04:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:04:11 INFO - Running setup.py (path:/tmp/pip-899Y_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:04:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:04:11 INFO - Running setup.py (path:/tmp/pip-4l2a6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:04:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:04:11 INFO - Running setup.py (path:/tmp/pip-krof5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:04:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:04:11 INFO - Running setup.py (path:/tmp/pip-PIm8Cf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:04:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:04:11 INFO - Running setup.py (path:/tmp/pip-ezN3Nb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:04:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:04:11 INFO - Running setup.py (path:/tmp/pip-TkcGry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:04:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:04:11 INFO - Running setup.py (path:/tmp/pip-LBrvNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:04:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:04:11 INFO - Running setup.py (path:/tmp/pip-r294kt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:04:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:04:11 INFO - Running setup.py (path:/tmp/pip-D1JC3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:04:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:04:11 INFO - Running setup.py (path:/tmp/pip-Ultg8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:04:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:04:11 INFO - Running setup.py (path:/tmp/pip-Omloxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:04:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:04:11 INFO - Running setup.py install for manifestparser 07:04:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:04:11 INFO - Running setup.py install for mozcrash 07:04:11 INFO - Running setup.py install for mozdebug 07:04:12 INFO - Running setup.py install for mozdevice 07:04:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:04:12 INFO - Running setup.py install for mozfile 07:04:12 INFO - Running setup.py install for mozhttpd 07:04:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:04:12 INFO - Running setup.py install for mozinfo 07:04:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:04:12 INFO - Running setup.py install for mozInstall 07:04:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:04:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:04:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:04:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:04:12 INFO - Running setup.py install for mozleak 07:04:12 INFO - Running setup.py install for mozlog 07:04:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:04:12 INFO - Running setup.py install for moznetwork 07:04:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:04:12 INFO - Running setup.py install for mozprocess 07:04:12 INFO - Running setup.py install for mozprofile 07:04:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:04:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:04:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:04:13 INFO - Running setup.py install for mozrunner 07:04:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:04:13 INFO - Running setup.py install for mozscreenshot 07:04:13 INFO - Running setup.py install for moztest 07:04:13 INFO - Running setup.py install for mozversion 07:04:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:04:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:04:13 INFO - Cleaning up... 07:04:13 INFO - Return code: 0 07:04:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:04: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')]} 07:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04: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')]} 07:04:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:13 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 0x239a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2563a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2706a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270a090>, '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 0x270ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2704f90>, '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': '9e0dfe3369c33a1556e63f89000001d8-1506002182.263489-733130944', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:04:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:04:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:04:13 INFO - Using env: {'DISPLAY': ':0', 07:04:13 INFO - 'HOME': '/home/cltbld', 07:04:13 INFO - 'LANG': 'en_US.UTF-8', 07:04:13 INFO - 'LANGUAGE': 'en_US:en', 07:04:13 INFO - 'LOGNAME': 'cltbld', 07:04:13 INFO - 'MAIL': '/var/mail/cltbld', 07:04:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:13 INFO - 'MOZ_NO_REMOTE': '1', 07:04:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:13 INFO - 'NO_EM_RESTART': '1', 07:04:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:13 INFO - 'PWD': '/builds/slave/test', 07:04:13 INFO - 'SHELL': '/bin/bash', 07:04:13 INFO - 'SHLVL': '1', 07:04:13 INFO - 'TERM': 'linux', 07:04:13 INFO - 'TMOUT': '86400', 07:04:13 INFO - 'USER': 'cltbld', 07:04:13 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506002182.263489-733130944', 07:04:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:13 INFO - '_': '/tools/buildbot/bin/python'} 07:04:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:04:13 INFO - Running setup.py (path:/tmp/pip-_zHMCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:04:13 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:04:13 INFO - Running setup.py (path:/tmp/pip-4fwkNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:04:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:04:13 INFO - Running setup.py (path:/tmp/pip-z97it_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:04:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:04:13 INFO - Running setup.py (path:/tmp/pip-oXxRqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:04:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:04:14 INFO - Running setup.py (path:/tmp/pip-Eibq9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:04:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:04:14 INFO - Running setup.py (path:/tmp/pip-LW0PjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:04:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:04:14 INFO - Running setup.py (path:/tmp/pip-Vf3kav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:04:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:04:14 INFO - Running setup.py (path:/tmp/pip-QKKBx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:04:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:04:14 INFO - Running setup.py (path:/tmp/pip-sPYBhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:04:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:04:14 INFO - Running setup.py (path:/tmp/pip-KXTjrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:04:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:04:14 INFO - Running setup.py (path:/tmp/pip-TlSoJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:04:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:04:14 INFO - Running setup.py (path:/tmp/pip-MOuerV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:04:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:04:14 INFO - Running setup.py (path:/tmp/pip-0W0Fi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:04:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:04:14 INFO - Running setup.py (path:/tmp/pip-VEeEnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:04:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:04:14 INFO - Running setup.py (path:/tmp/pip-f5kvu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:04:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:04:14 INFO - Running setup.py (path:/tmp/pip-mvH_90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:04:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:04:14 INFO - Running setup.py (path:/tmp/pip-EzvS9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:04:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:04:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:04:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:04:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:04:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:04:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:04:14 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:04:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:04:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:16 INFO - Downloading blessings-1.6.tar.gz 07:04:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:04:16 INFO - Installing collected packages: blessings 07:04:16 INFO - Running setup.py install for blessings 07:04:16 INFO - Successfully installed blessings 07:04:16 INFO - Cleaning up... 07:04:16 INFO - Return code: 0 07:04:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:04:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:04:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:04:16 INFO - Reading from file tmpfile_stdout 07:04:16 INFO - Current package versions: 07:04:16 INFO - argparse == 1.2.1 07:04:16 INFO - blessings == 1.6 07:04:16 INFO - blobuploader == 1.2.4 07:04:16 INFO - docopt == 0.6.1 07:04:16 INFO - functools32 == 3.2.3-2 07:04:16 INFO - jsonschema == 2.5.1 07:04:16 INFO - manifestparser == 1.1 07:04:16 INFO - mozInstall == 1.13 07:04:16 INFO - mozcrash == 1.0 07:04:16 INFO - mozdebug == 0.1 07:04:16 INFO - mozdevice == 0.51 07:04:16 INFO - mozfile == 1.2 07:04:16 INFO - mozhttpd == 0.7 07:04:16 INFO - mozinfo == 0.10 07:04:16 INFO - mozleak == 0.1 07:04:16 INFO - mozlog == 3.5 07:04:16 INFO - moznetwork == 0.27 07:04:16 INFO - mozprocess == 0.25 07:04:16 INFO - mozprofile == 0.28 07:04:16 INFO - mozrunner == 6.13 07:04:16 INFO - mozscreenshot == 0.1 07:04:16 INFO - mozsystemmonitor == 0.3 07:04:16 INFO - moztest == 0.8 07:04:16 INFO - mozversion == 1.4 07:04:16 INFO - psutil == 3.1.1 07:04:16 INFO - requests == 1.2.3 07:04:16 INFO - wsgiref == 0.1.2 07:04:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:04:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:16 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 0x239a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2563a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2706a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270a090>, '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 0x270ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2704f90>, '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': '9e0dfe3369c33a1556e63f89000001d8-1506002182.263489-733130944', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:04:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:04:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:04:16 INFO - Using env: {'DISPLAY': ':0', 07:04:16 INFO - 'HOME': '/home/cltbld', 07:04:16 INFO - 'LANG': 'en_US.UTF-8', 07:04:16 INFO - 'LANGUAGE': 'en_US:en', 07:04:16 INFO - 'LOGNAME': 'cltbld', 07:04:16 INFO - 'MAIL': '/var/mail/cltbld', 07:04:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:16 INFO - 'MOZ_NO_REMOTE': '1', 07:04:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:16 INFO - 'NO_EM_RESTART': '1', 07:04:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:16 INFO - 'PWD': '/builds/slave/test', 07:04:16 INFO - 'SHELL': '/bin/bash', 07:04:16 INFO - 'SHLVL': '1', 07:04:16 INFO - 'TERM': 'linux', 07:04:16 INFO - 'TMOUT': '86400', 07:04:16 INFO - 'USER': 'cltbld', 07:04:16 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506002182.263489-733130944', 07:04:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:16 INFO - '_': '/tools/buildbot/bin/python'} 07:04:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:04:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:04:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:04:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:04:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:04:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:04:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:04:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:04:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:04:16 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 07:04:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 07:04:17 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:04:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:04:17 INFO - Installing collected packages: simplejson 07:04:17 INFO - Running setup.py install for simplejson 07:04:18 INFO - building 'simplejson._speedups' extension 07:04:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 07:04:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 07:04:18 INFO - Successfully installed simplejson 07:04:18 INFO - Cleaning up... 07:04:18 INFO - Return code: 0 07:04:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:04: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')]} 07:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04: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')]} 07:04:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2563a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2706a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270a090>, '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 0x270ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2704f90>, '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': '9e0dfe3369c33a1556e63f89000001d8-1506002182.263489-733130944', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:04: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', 'jsonschema'] in /builds/slave/test/build 07:04: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 jsonschema 07:04:18 INFO - Using env: {'DISPLAY': ':0', 07:04:18 INFO - 'HOME': '/home/cltbld', 07:04:18 INFO - 'LANG': 'en_US.UTF-8', 07:04:18 INFO - 'LANGUAGE': 'en_US:en', 07:04:18 INFO - 'LOGNAME': 'cltbld', 07:04:18 INFO - 'MAIL': '/var/mail/cltbld', 07:04:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:18 INFO - 'MOZ_NO_REMOTE': '1', 07:04:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:18 INFO - 'NO_EM_RESTART': '1', 07:04:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:18 INFO - 'PWD': '/builds/slave/test', 07:04:18 INFO - 'SHELL': '/bin/bash', 07:04:18 INFO - 'SHLVL': '1', 07:04:18 INFO - 'TERM': 'linux', 07:04:18 INFO - 'TMOUT': '86400', 07:04:18 INFO - 'USER': 'cltbld', 07:04:18 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506002182.263489-733130944', 07:04:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:19 INFO - '_': '/tools/buildbot/bin/python'} 07:04:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:04:19 INFO - Cleaning up... 07:04:19 INFO - Return code: 0 07:04:19 INFO - Running post-action listener: _resource_record_post_action 07:04:19 INFO - Running post-action listener: _start_resource_monitoring 07:04:19 INFO - Starting resource monitoring. 07:04:19 INFO - [mozharness: 2017-09-21 14:04:19.253897Z] Finished create-virtualenv step (success) 07:04:19 INFO - [mozharness: 2017-09-21 14:04:19.254371Z] Running install step. 07:04:19 INFO - Running pre-action listener: _resource_record_pre_action 07:04:19 INFO - Running main action method: install 07:04:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:04:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:04:19 INFO - Reading from file tmpfile_stdout 07:04:19 INFO - Detecting whether we're running mozinstall >=1.0... 07:04:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:04:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:04:19 INFO - Reading from file tmpfile_stdout 07:04:19 INFO - Output received: 07:04:19 INFO - Usage: mozinstall [options] installer 07:04:19 INFO - Options: 07:04:19 INFO - -h, --help show this help message and exit 07:04:19 INFO - -d DEST, --destination=DEST 07:04:19 INFO - Directory to install application into. [default: 07:04:19 INFO - "/builds/slave/test"] 07:04:19 INFO - --app=APP Application being installed. [default: firefox] 07:04:19 INFO - mkdir: /builds/slave/test/build/application 07:04:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:04:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:04:37 INFO - Reading from file tmpfile_stdout 07:04:37 INFO - Output received: 07:04:37 INFO - /builds/slave/test/build/application/firefox/firefox 07:04:37 INFO - Running post-action listener: _resource_record_post_action 07:04:37 INFO - [mozharness: 2017-09-21 14:04:37.419474Z] Finished install step (success) 07:04:37 INFO - [mozharness: 2017-09-21 14:04:37.419640Z] Running setup-mitmproxy step. 07:04:37 INFO - Running pre-action listener: _resource_record_pre_action 07:04:37 INFO - Running main action method: setup_mitmproxy 07:04:37 INFO - Skipping: mitmproxy is not required 07:04:37 INFO - Running post-action listener: _resource_record_post_action 07:04:37 INFO - [mozharness: 2017-09-21 14:04:37.420771Z] Finished setup-mitmproxy step (success) 07:04:37 INFO - [mozharness: 2017-09-21 14:04:37.420996Z] Running run-tests step. 07:04:37 INFO - Running pre-action listener: _resource_record_pre_action 07:04:37 INFO - Running pre-action listener: _set_gcov_prefix 07:04:37 INFO - Running main action method: run_tests 07:04:37 WARNING - Try message not found. 07:04:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:04:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:04:37 INFO - Python 2.7.3 07:04:37 INFO - Return code: 0 07:04:37 INFO - grabbing minidump binary from tooltool 07:04:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:37 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270a090>, '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 0x270ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2704f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:04:37 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:04:37 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:04:37 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:04:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:04:37 INFO - Return code: 0 07:04:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:04:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:04:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:04:37 INFO - ENV: RUST_BACKTRACE is now full 07:04:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:04:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:04:37 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/OR_WzdNeS6ee0KU9V4iMiw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 07:04:37 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/OR_WzdNeS6ee0KU9V4iMiw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-040 --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 07:04:37 INFO - Using env: {'DISPLAY': ':0', 07:04:37 INFO - 'HOME': '/home/cltbld', 07:04:37 INFO - 'LANG': 'en_US.UTF-8', 07:04:37 INFO - 'LANGUAGE': 'en_US:en', 07:04:37 INFO - 'LOGNAME': 'cltbld', 07:04:37 INFO - 'MAIL': '/var/mail/cltbld', 07:04:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:04:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:04:37 INFO - 'MOZ_ACCELERATED': '1', 07:04:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:37 INFO - 'MOZ_NO_REMOTE': '1', 07:04:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:04:37 INFO - 'MOZ_WEBRENDER': '1', 07:04:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:37 INFO - 'NO_EM_RESTART': '1', 07:04:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:37 INFO - 'PWD': '/builds/slave/test', 07:04:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:04:37 INFO - 'RUST_BACKTRACE': 'full', 07:04:37 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:04:37 INFO - 'SHELL': '/bin/bash', 07:04:37 INFO - 'SHLVL': '1', 07:04:37 INFO - 'TERM': 'linux', 07:04:37 INFO - 'TMOUT': '86400', 07:04:37 INFO - 'USER': 'cltbld', 07:04:37 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506002182.263489-733130944', 07:04:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:37 INFO - '_': '/tools/buildbot/bin/python'} 07:04:37 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/OR_WzdNeS6ee0KU9V4iMiw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 07:04:37 INFO - mozversion application_buildid: 20170921131427 07:04:37 INFO - mozversion application_changeset: 9caeafcec9982be90820e30bc699e851cb6af907 07:04:37 INFO - mozversion application_display_name: Nightly 07:04:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:04:37 INFO - mozversion application_name: Firefox 07:04:37 INFO - mozversion application_remotingname: firefox 07:04:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:04:37 INFO - mozversion application_vendor: Mozilla 07:04:37 INFO - mozversion application_version: 57.0a1 07:04:37 INFO - mozversion platform_buildid: 20170921131427 07:04:37 INFO - mozversion platform_changeset: 9caeafcec9982be90820e30bc699e851cb6af907 07:04:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:04:37 INFO - mozversion platform_version: 57.0a1 07:04:37 INFO - using testdate: 1506002677 07:04:37 INFO - actual date: 1506002677 07:04:37 INFO - starting webserver on 'localhost:59449' 07:04:37 INFO - SUITE-START | Running 2 tests 07:04:37 INFO - TEST-START | dromaeo_css 07:04:37 INFO - Initialising browser for dromaeo_css test... 07:04:37 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59449/getInfo.html -profile /tmp/tmp73pMbP/profile 07:04:37 INFO - TEST-INFO | started process 19008 (/builds/slave/test/build/application/firefox/firefox http://localhost:59449/getInfo.html) 07:04:43 INFO - TEST-INFO | 19008: exit 0 07:04:44 INFO - Browser initialized. 07:04:44 INFO - Running cycle 1/1 for dromaeo_css test... 07:04:44 INFO - Using env: {'DISPLAY': ':0', 07:04:44 INFO - 'HOME': '/home/cltbld', 07:04:44 INFO - 'JSGC_DISABLE_POISONING': '1', 07:04:44 INFO - 'LANG': 'en_US.UTF-8', 07:04:44 INFO - 'LANGUAGE': 'en_US:en', 07:04:44 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 07:04:44 INFO - 'LOGNAME': 'cltbld', 07:04:44 INFO - 'MAIL': '/var/mail/cltbld', 07:04:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:04:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:04:44 INFO - 'MOZ_ACCELERATED': '1', 07:04:44 INFO - 'MOZ_CRASHREPORTER': '1', 07:04:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:44 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 07:04:44 INFO - 'MOZ_NO_REMOTE': '1', 07:04:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:04:44 INFO - 'MOZ_WEBRENDER': '1', 07:04:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:44 INFO - 'NO_EM_RESTART': '1', 07:04:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:44 INFO - 'PWD': '/builds/slave/test', 07:04:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:04:44 INFO - 'RUST_BACKTRACE': 'full', 07:04:44 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:04:44 INFO - 'SHELL': '/bin/bash', 07:04:44 INFO - 'SHLVL': '1', 07:04:44 INFO - 'TERM': 'linux', 07:04:44 INFO - 'TMOUT': '86400', 07:04:44 INFO - 'USER': 'cltbld', 07:04:44 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506002182.263489-733130944', 07:04:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:44 INFO - '_': '/tools/buildbot/bin/python'} 07:04:44 INFO - TEST-INFO | started process 19257 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp73pMbP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:04:44 INFO - PID 19257 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 07:04:45 INFO - PID 19257 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 07:04:45 INFO - PID 19257 | 07:04:45 INFO - PID 19257 | (/builds/slave/test/build/application/firefox/firefox:19318): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:04:45 INFO - PID 19257 | 07:04:55 INFO - PID 19257 | RSS: Main: 207339520 07:04:55 INFO - PID 19257 | 07:07:53 INFO - PID 19257 | Cycle 1(1): loaded http://localhost:59449/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59449/tests/dromaeo/cssquery-ext.html) 07:07:54 INFO - PID 19257 | RSS: Main: 208285696 07:07:54 INFO - PID 19257 | 07:10:57 INFO - PID 19257 | Cycle 1(1): loaded http://localhost:59449/tests/dromaeo/cssquery-ext.html (next: http://localhost:59449/tests/dromaeo/cssquery-jquery.html) 07:10:57 INFO - PID 19257 | RSS: Main: 209563648 07:10:57 INFO - PID 19257 | 07:14:00 INFO - PID 19257 | Cycle 1(1): loaded http://localhost:59449/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59449/tests/dromaeo/cssquery-mootools.html) 07:14:00 INFO - PID 19257 | RSS: Main: 208404480 07:14:00 INFO - PID 19257 | 07:17:02 INFO - PID 19257 | Cycle 1(1): loaded http://localhost:59449/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59449/tests/dromaeo/cssquery-prototype.html) 07:17:03 INFO - PID 19257 | RSS: Main: 206721024 07:17:03 INFO - PID 19257 | 07:20:07 INFO - PID 19257 | Cycle 1(1): loaded http://localhost:59449/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59449/tests/dromaeo/cssquery-yui.html) 07:20:07 INFO - PID 19257 | RSS: Main: 211324928 07:20:07 INFO - PID 19257 | 07:23:09 INFO - PID 19257 | Cycle 1(1): loaded http://localhost:59449/tests/dromaeo/cssquery-yui.html (next: http://localhost:59449/tests/dromaeo/cssquery-dojo.html) 07:23:10 INFO - PID 19257 | RSS: Main: 214126592 07:23:10 INFO - PID 19257 | 07:23:10 INFO - PID 19257 | __start_tp_report 07:23:10 INFO - PID 19257 | _x_x_mozilla_page_load 07:23:10 INFO - PID 19257 | _x_x_mozilla_page_load_details 07:23:10 INFO - PID 19257 | |i|pagename|runs| 07:23:10 INFO - PID 19257 | |0;dojo.html;3078.7383072438843;3089.7682673799472;3107.06787963611;3129.2333378322314;3145.6539780624125;6032.185654936582;6176.722047507862;6242.5630205885545;6273.996160614302;6327.955887278599;6192.287886893008;6203.844903877405;6246.500279977602;6310.305866354697;6324.7470101195895;5694.430556944314;5742.196092547047;5744.253247077884;5769.249997500319;5852;5828.242328497311;5838.708064596774;5852.941470585282;5891.8527036824;5948.970255148718;1343.827507069617;5848;5856.76572937082;5926.496247818941;5939.1388248703915;5722;5743.684097374643;5779.855503612402;5834.824955251349;5879.79420720277;5687.800926967578;5769.5672824537905;5813.6221145625395;5826.679532625704;5845.941540584625;6212.378762123752;6282.87434251317;6284.34014428483;6335.334789847046;6411.070394792776;6655.367740064686;6756.93243067568;6769.0861733665815;6790.354916282995;6816.318368163194;6792.21889482706;6839.179298484214;6886;6887.7244910203535;6917.619530925797;6102.786402475892;6199;6214.65819379934;6241.063840423927;6258.561900667;6788.389044985975;6849.452043836481;6868.965655171792;6880.724771009103;6896.620685862325;6538;6586.670666466657;6658.5671931324305;6673.1992160941;6713;6679.432248258952;6697.8995315070315;6704.229013663394;6728.360805723449;6730.360615741497;6726.7981960541265;6749.595024298558;6777.457803375718;6810.489213309022;6819.079424277659;6479.481641468766;6698.8995165072565;6713.56361836479;6729.730810767514;6823.215330236987;5261.079311120615;5287.9735601321745;5293.57651387888;5308.283381743492;5308.548773354308;4480.171168333869;4558.407407037064;4581.931271030937;4588.357629931812;4610.585047345755;5821.09772985188;5835.854103647443;5843.883122337615;5880.8235752927485;5883.17635531026;6821.727130914807;6831.419329357061;6837.247902730695;6878.65606719662;6922.688479018456;5636.379998200195;5783.595148339576;5821.27234095738;5863.120531920161;5867.266591676041;5668.7165641718575;5708.20085188074;5733.168690539848;5743.655380677173;5750.02249617566;6428.325025872309;6487.870242595121;6525.282218955911;6563.7702680405955;6569.605823650596;6755.898661520179;6781.287964763629;6784.457243420515;6789.287124852017;6866.382025617719;6512;6530.869382612226;6604.14146160996;6610.8016759497295;6622.8344291393105;6414.743410263537;6529.804105876831;6645;6721.731130754715;6733.966330168514;6714.865702686016;6724.865502690017;6726.461883049246;6776.119104516381;6786.728530858908;6447.677616119269;6470.029495575702;6512.902306465501;6531.281559028408;6583.967080164569;6618.172728408949;6625.271220165874;6641.568298060611;6687.799366019027;6687.899681504879;6422.293547709654;6483.384078512534;6501.382368674968;6563;6575.967120164369;6459.386358295955;6478.838029049311;6588.308227636221;6642.634655094016;6679.332066793476;6349.746010159727;6414.807555773335;6433.678316084083;6434.06706027614;6470.870582588416 07:23:10 INFO - PID 19257 | |1;ext.html;870.4994628088849;882.5984177199375;884.2351366068351;885.5439448683925;892.8749975003501;38078.23843523128;41733;41927.79036104823;42026.789866050705;42183.36724949128;38852.611473885256;38953.41569876454;38994.80502597483;39073;39455.21089578207;7058.823529411755;7159.821004474904;7226.205117437078;7245.203027666952;7259.455540834432;7038.26098259683;7207.89188162178;7211.711531538732;7218.458615603825;7231.529950553224;7146.178189508221;7219.963900180518;7231.023811785421;7247.492675512716;7903.130655627905;8057.033156021285;8110.472819266729;8118.63466144019;8143.470674406145;8154.184581541857;7974.322182614426;8051.798705032421;8056.879146812803;8070.47541909774;8070.55611941343;38139;38781.80609096964;38860.22279554393;39051.60948390508;39152.60847391518;3484.756067075306;3539.964600354015;3541.6458354164633;3564.928701425957;3567.0369000369756;31667.891623793286;32202;32223;32246.355072898645;32417.351652967045;5194.480551944813;5196.662216955886;5217.139172036609;5220.504052115043;5246.8688282792855;189727;190927;191242;191643;192019.03990479957;43057.56942430536;43971.34042989358;47273;47594.5240547597;47955.280670789965;50267;50776.74611626992;51086.23370649443;51129.23306150411;51157.953681853054;14693.55919322422;14695.77956330656;14731.705365892622;14818.851811481964;14824.481143159937;11781.705457363634;11852.466639001266;11874.881251187551;11875.88124118765;11952;14099.929500352433;14119.152850828983;14196.432142714382;14273.785893211403;14441.06133101345;5591.993441180626;5787.913181302284;5798.188253644493;5800.941990580124;5854.297484301911;988.8763904511936;1010.9191264698807;1024.1908891975404;1029.6807989523272;1037.0355569320604;23362.64956025661;23370.831458427012;23704.762952370256;23849.165279215144;23903;1096.873859506167;1101.388729255271;1111.4942701070993;1117.212365282474;1118.8657361116718;12251.816222756666;12415.565455209024;12515.249085054926;12542.937285313697;12563.937180314222;228391;228409;229000;229187;229760;51682;51701;52043.73978130085;52714.73642631839;52773.472265277625;1381.896357773171;1424.7150569886064;1446.3274577321597;1454.403694485256;1457.103881113129;22431.77568224297;22928.19751308696;23089.845507724884;23167;23234.53530929338;36477.45283820798;36547.45178822373;36625.26749465049;36642.633573664985;36670.266594667424;187985;190598;191444;191491;191635;29822.25444363908;31856.203594910312;33690.83154584211;33873.830630846685;33885.66114338825;42799.1440171201;43282.35076473792;43631.56368436275;43664.345034825135;43798;32403.18992025218;32510.187245319055;32595.18512037218;32619.34761304808;32901;31686.841565792023;32008.5198722024;32028.03915882527;32682.182945426553;32761;35729.64270357367;35873.28253434865;35884.28231435409;36044.27911441704;36606.267874641824;31169.8441507791;31591.368172636878;31838.681613183573;31911;32021;22844.771552284263;23980.40048998719;23994.64810811587;24243.75756242415;24393.756062439148 07:23:10 INFO - PID 19257 | |2;jquery.html;579.3627010288683;580.973856176472;584.5206930317139;602.2411761180912;610.9480694140997;21724.89137554312;22313.665295020586;22324.218652347172;22385.776142238614;22406.55186896263;21602.243921462752;24272.514549709038;24351.878240608774;24369.390765230877;24694.50610987779;6340.587861788992;6415.8396040098905;6464.385883341075;6473.126127972734;6474.9676251618675;6362.268339140988;6405.615663060208;6441.549091563593;6451.7096730647;6456.58032227906;6145.385461453863;6511.413972742453;6525.347465253484;6533.673316334188;6549.738010479575;6542.7710030148955;6567.211934567882;6574.276829548746;6581.045748366508;6581.3747693969235;6092.573519853612;6114.816555503342;6139.201903752528;6151.5386346024225;6164.229471316085;27082.593761093598;27911.58132628012;28365.149045528666;28531.57202641962;28619.427611447863;1995.7006449032617;2033.8169564739244;2034.5930813837144;2036.6334059869218;2043.0704029666465;19256.903715481472;19456.70814937777;19518.414447566596;19548;19562.70655940162;2371.9288421347214;2377.8811059446957;2404.507076049406;2441.011390386896;2459.2622213335926;124869.37565312206;128604.35697821545;130852;133435.33282333624;135271.32364338214;14582.702643685643;14708.33812478441;14842.257887105601;14878.07315610625;14999.250037498081;23079.769202308096;23093.769062309497;23115.422114447272;23203.767962320497;23206.883965580066;9087.545622718837;9125.17873391398;9203.815923681488;9245.768855778659;9251.90748092524;7894.289513943772;7911.723089691834;8002.5998700064765;8048.637811298506;8063.314618257396;9036.186743193144;9106.362554621246;9111.537615705989;9122.543872806466;9247.907520924704;2751.917442476729;2768.418632087244;2778.652668416448;2802.369466869938;2860.8140470869325;945.8013817098349;952.3095755577151;962.4658314635444;968.2592816495387;968.4286271100085;18859.86840789557;18884.24463021491;19346.8065319345;19461.610767784565;19626.607467850565;1007.7027276953316;1011.610529945976;1017.7811770469236;1018.4551265073151;1021.9897801021895;10528;10703.250772445854;10823.188260880466;10930.56277748881;10966.561337546409;436531;437194;448222;464710;465944;114157;114908;115822.4208878967;117015;118874;1002.4987506246877;1122.825961975895;1132.9886701133048;1191.0471622701978;1193.230366413641;19836;20143;20200.393988180378;20447.28434504785;20452.693209602166;56038;56162.7191864038;57724;57872.71063644823;58688;70357;72378.63810681124;72485;73596.63201683958;74059.25940740739;14356.85643143597;14444.927775361057;14521.709565808413;14570.198639074528;14606.707865842836;21975.560488790456;22055.66916496222;22083.895805209355;22260.554788904454;22522.549549009254;17984.550386239924;18058.909705451388;18108.547286317946;18117.909410452863;18335.35826246075;15789.842101578837;16267.51197464078;16390;16465.176741163134;16523.586910327336;17731.911340443214;18040.368587099387;18066.36767713124;18261;18352.724709129106;14162.079464834753;14284.785728213878;14284.928575357057;14301.856981430052;14303.427862885368;17460.21429035671;17871.73192402141;17877.28490860403;18014.72977905306;18032.188551515475 07:23:10 INFO - PID 19257 | |3;mootools.html;1176.053277111925;1196.1387800783432;1196.6290449960513;1202.518992403039;1222.1261797814554;15712.842871571294;16351.182440877938;16415;16481.917590412046;16529.83470165298;15938.442154524593;15963.521094367188;16058.83941160588;16128.83871161288;16160;2777.3334399744017;2790.595363672266;2816.788740844445;2823.9435211295763;2824.6751623563246;2665.6134860445222;2774.0429551804696;2799.258196577898;2801.90193343233;2802.6776920654183;2676.5583678693088;2682.2757855379036;2696.4876673431986;2715.3483164040586;2725.1007167634734;2617.3718307606227;2623.908163214288;2641.141628970573;2649.576067829138;2659.3085797692643;2574.742525747429;2610.85640289784;2625.0024990503675;2628.3823301524317;2640.234332043705;15132.319045642973;15177.24113794306;15282.694346113016;15293.082415055133;15307.617309567238;7908.565028923407;8101.149379315146;8332.250097491195;8522.531260780655;8577.356698247657;5337.412884582693;5522.0336441122645;5566.860828479321;5582.944170558283;5630.774769009235;1925.682262426698;1999.530110424049;2015.7077223802612;2032.6768349869253;2044.2334124703236;24232.515349693083;24966.625500617505;25059.248222553353;25681.614775778376;25687.357816054748;6990.882929070678;7007.229204787469;7245.7826265212125;7249.710011599583;7268.273172682795;17838.91080544615;17978.280868765363;17995.73006404905;18059.187336569885;18113.637727245383;8103.351731861437;8173.795655108551;8187.5087494750505;8230.135835737281;8236.052853921756;7285.927140728631;7554.508956917783;7613.200613935568;7742.961285193538;7755.379569634416;5324.254604355393;5510.9448905510435;5580;5604.131359639263;5612.158176273591;1554.207354249341;1586.8413158684039;1588.269396077794;1594.609320716432;1603.0862408427085;866.4498043742269;868.9608967596473;896.4352457951579;908.9863652045225;919.2645883293338;7622.390208783284;7649.77603583424;7675.731349402856;7675.769726908202;7694.769156925301;714.310690183975;736.731093150996;739.3456790740127;743.6170372258291;750.4184257200714;5348;5453.918191227135;5479.260299859548;5581.441855814467;5600.159976003551;21625.459363516038;22119.668204976617;22385.776142238694;22584.435389115402;22731;21228;21783.34649960504;22483.775162248166;22496.32511024672;22672.773272267066;11068;11260;11408.201425900274;11431.485583148778;11504.022158116653;8319.209675080858;8568.871466928125;8693.739187824376;8707.47755134694;8763.518006509703;18083;18965.90517047406;19081.90459047696;19199;19393;19475.513112171742;19599.70600440966;20108;20154.39536813898;20259.18963241454;10985.835212471979;11152.609658661908;11153.944230279121;11178;11257.831132532854;13664.93167534156;13970.30148492551;14284.500042498463;14408.42366305336;14442.133471991714;10748.677539673823;11406.258593191416;11510.36692981894;11712.590059347882;11726.589569365031;11104.444777760918;11487.310761354345;11622.593209237637;11659.76680466369;11720.300556419443;10075.949620251851;10289.691309260734;10339.22455815832;10350.378977261389;10397.844032339672;7485.7754267372065;7519.248075192656;7639.847203055797;7667.46327757074;7718.073831140075;6963.825904352229;7006.299370062953;7051.083359163276;7113.110861142357;7175.461840362098 07:23:10 INFO - PID 19257 | |4;prototype.html;498.6509443389626;513.2737176894694;525.5509326538331;531.7474199755119;537.9892402151957;6021.367756385582;6223.844403889893;6317.36826317368;6336.398042185991;6392.200974878146;5977.790777322794;6035.305939816923;6045.818625441233;6162.168107305512;6201;4770.522947705219;4998.57512111471;5000.7249601271915;5007.699538027712;5046.82336118236;4954.554090131887;4961.883576195363;4981.526754958273;5009.649324547283;5066.1640829263315;4910.140725373063;4959.677620954644;4986.75066246688;5008.824691135811;5020.748962551857;4963.1636294571235;4964.485831821293;4985.626078044161;4992.975035124819;5013.348264725562;4438;4469.597736203725;4488.932666010012;4534.478534968488;4535.614472769818;6084.756609735649;6093.451589356979;6121.724522396503;6142.324344322121;6144.723487443076;5701.25883635129;5705.971470142623;5748.2527271454865;5752.879936856201;5764.164196191528;6355.650439225841;6437.903431448532;6474.741010359627;6509.934900651027;6541.28045914949;4825.879353016167;4853.199222128344;4862.513748625144;4887.584555312803;4948.802047918079;6827.829304267433;6904.689288982008;6929.272426395206;6938.444924406086;6959.721611135599;5079.4412614612365;5083.204237669267;5103.362079740033;5118.360204974379;5121.948780512222;5057.342545469065;5065.898682026339;5070.7464626768515;5087.186050231945;5095.566876815438;5680.4319568042865;5686.800961966312;5729.221327656083;5738.225339579187;5775.595708300379;6246.187995560548;6422.678866056678;6615.702293396808;6638.805015097232;6705.798826035227;1605.855473007435;1674.8610944557574;1716.8025677047049;1757.885737427063;1763.4621440460783;1214.908881833866;1222.2177806204036;1231.4581584102966;1265.639292801547;1270.9555165569345;5515.172724091338;5535.889282214333;5577.386487486373;5660.8867822643315;5691.9146212806845;6567.376099270562;6577.14497115372;6584.012398140221;6591.43972762311;6623.205215374186;5550.888982220333;5608.803691870765;5671.716414179357;5675.432456754292;5689.516391106719;3503.1417302760988;3524.5770507538746;3549.911252218715;3577.284543091392;3588.7308451866215;6360.77737279193;6371.299157092716;6424.293327733945;6445.45213656835;6445.742170313229;6620.304867988888;6649.235337936103;6659.267480577133;6742.325767423218;6960.582365058112;6368.936310636927;6392.904106438407;6423.454006409414;6429.935700642934;6492;6580.5722628029025;6664.566803157779;6729.831754206184;6737.225219099866;6747.628880411625;6537.5484193427465;6595.934040659532;6667.43326817226;6695.799126026032;6710.496712746466;6431.903521447276;6442.742290308335;6447.806565803034;6469.838254043687;6496.252930913006;4935.333729946411;5021.874453138701;5068.417132029864;5081.669691470042;5089.338386009795;6440.227172739301;6704.4301234395625;6826.658667066726;6869.416099631388;6875.349916020019;5973.611715238496;6304.590201636879;6345.7144428499905;6413.839654008687;6452.870942581216;6444.581102228341;6467.773627923;6471.514636402195;6545.574537655038;6566.4418524425955;6370.394812492806;6392.584482008655;6445.387688169616;6457.67711614408;6482.513811464065;6524.739010439529;6546.770863019771;6574.901376479261;6647.800565983028;6667.799966001027;6315.463185629089;6316.305206427382;6335.841603959938;6409.230892292955;6409.487241020801 07:23:10 INFO - PID 19257 | |5;yui.html;853.3216093205901;863.9416714524704;891.1133422244867;898.7842917699754;900.5902314446923;19308.51728706783;20226.797732022675;20349.28777492788;20386;20392.59214815703;18252.26990920365;18598.90700546499;18759.43721688348;18857.15142818573;18969.24123035077;936.2790651198573;961.1589858873485;962.3600305796672;964.2671569607114;966.3766870368609;971.2230215827345;974.9470571782458;978.496074521622;983.2625530851861;984.5274268351196;1005.5525291245399;1040.6357774778842;1042.47876061969;1045.3988956350129;1047.4239168457357;1027.4862568715641;1031.4791030529534;1031.4894127406944;1034.5034383495927;1036.1917704190744;724.2178447276981;731.3783284208433;743.680217506472;748.9737859174903;754.4944886925718;20283.594328113355;20491.897540512353;20672.793272067236;20686.172553098007;20716;21629.891850540647;22000.229991950364;22626.77373226263;22712.318630441114;22770.886145569333;17051;17101.657966840594;17142.742858857127;17278.65442691139;17375.218115184845;3665.6334366563397;3712.201876596545;3718.2749363874054;3739.495168152319;3753.5871054184017;139838.30080849634;140299;141761;142752.28623856918;143548;16902.57743556421;17478.388256411217;17514.29942802299;17526;17540;31069.533956990665;32002.679973200437;32159.839200803846;32496.187595309835;33122.50316245258;8154;8364.414490985695;8425.199606037417;8437.95781021091;8470.280026197843;4205.201011807808;4213.241616509058;4244.745315281093;4249.766262855511;4300.483941926988;5410.702411367412;5516.531094856902;5542.97228513863;5555.666660000413;5571.832845014656;1021.9795604087876;1030.3611760708409;1039.1634734039171;1044.639599338227;1051.5530899367739;641.0992555459587;643.411278680012;661.966901654925;673.619405036153;684.8424862281703;11176.27354221973;11207.38359390225;11250.642872479008;11291.661250162344;11404.030657394049;669.9765508207287;673.2795908377989;687.4363022321648;692.1452006771633;699.9615021173782;5337.2794672719465;5370.113931201387;5429.267048948421;5536.114221724505;5553.278073850373;124964;127538;131124;133020;134197.32901335432;112715.43642281737;113019.43490282496;115416.42291788488;115737.4213128929;119237.40381298211;98634;99027;99167;99872;100632.49683751681;9659.275554333593;9774.85337719949;10010.799784004425;10222.233332499944;10290.639827605997;44983.55016449794;46266.76866615645;46584;47370;48016.27975580439;59702.10446843388;60931;61249.69375153274;61312.386876132456;62304.68847655733;14433.35049922735;14681.19253441071;14721.631959201106;14825.555233343017;15045.623859403602;16755.497335079966;16926;16952.491425257263;17089.572760681083;17376.652466950844;13345.399457024652;13457.663558410726;13739.106958047694;13794.862051379358;13886.09740366873;16367.263473143976;16434.506964791075;16483.423080192137;16504.092274924995;16744.497665070066;14807.333669985092;14867.92566037163;14964.850351496782;14984.100953942798;15174.848251517344;11782.646520604396;12051.096167787626;12076.758464830478;12110.35542670661;12285;10714.785704286027;10846.13230941507;10848.403337816495;10917.23579349438;11009 07:23:10 INFO - PID 19257 | __end_tp_report 07:23:10 INFO - PID 19257 | __start_cc_report 07:23:10 INFO - PID 19257 | _x_x_mozilla_cycle_collect,294 07:23:10 INFO - PID 19257 | __end_cc_report 07:23:10 INFO - PID 19257 | __startTimestamp1506003790071__endTimestamp 07:23:10 INFO - PID 19257 | 07:23:10 INFO - PID 19257 | ------- Summary: start ------- 07:23:10 INFO - PID 19257 | Number of tests: 6 07:23:10 INFO - PID 19257 | 07:23:10 INFO - PID 19257 | [#0] dojo.html Cycles:165 Average:6168.24 Median:6447.68 stddev:843.88 (13.1%) stddev-sans-first:810.92 07:23:10 INFO - PID 19257 | Values: 3078.7 3089.8 3107.1 3129.2 3145.7 6032.2 6176.7 6242.6 6274.0 6328.0 6192.3 6203.8 6246.5 6310.3 6324.7 5694.4 5742.2 5744.3 5769.2 5852.0 5828.2 5838.7 5852.9 5891.9 5949.0 1343.8 5848.0 5856.8 5926.5 5939.1 5722.0 5743.7 5779.9 5834.8 5879.8 5687.8 5769.6 5813.6 5826.7 5845.9 6212.4 6282.9 6284.3 6335.3 6411.1 6655.4 6756.9 6769.1 6790.4 6816.3 6792.2 6839.2 6886.0 6887.7 6917.6 6102.8 6199.0 6214.7 6241.1 6258.6 6788.4 6849.5 6869.0 6880.7 6896.6 6538.0 6586.7 6658.6 6673.2 6713.0 6679.4 6697.9 6704.2 6728.4 6730.4 6726.8 6749.6 6777.5 6810.5 6819.1 6479.5 6698.9 6713.6 6729.7 6823.2 5261.1 5288.0 5293.6 5308.3 5308.5 4480.2 4558.4 4581.9 4588.4 4610.6 5821.1 5835.9 5843.9 5880.8 5883.2 6821.7 6831.4 6837.2 6878.7 6922.7 5636.4 5783.6 5821.3 5863.1 5867.3 5668.7 5708.2 5733.2 5743.7 5750.0 6428.3 6487.9 6525.3 6563.8 6569.6 6755.9 6781.3 6784.5 6789.3 6866.4 6512.0 6530.9 6604.1 6610.8 6622.8 6414.7 6529.8 6645.0 6721.7 6734.0 6714.9 6724.9 6726.5 6776.1 6786.7 6447.7 6470.0 6512.9 6531.3 6584.0 6618.2 6625.3 6641.6 6687.8 6687.9 6422.3 6483.4 6501.4 6563.0 6576.0 6459.4 6478.8 6588.3 6642.6 6679.3 6349.7 6414.8 6433.7 6434.1 6470.9 07:23:10 INFO - PID 19257 | 07:23:10 INFO - PID 19257 | [#1] ext.html Cycles:180 Average:37133.62 Median:3540.81 stddev:52924.60 (1494.7%) stddev-sans-first:53003.02 07:23:10 INFO - PID 19257 | Values: 870.5 882.6 884.2 885.5 892.9 38078.2 41733.0 41927.8 42026.8 42183.4 38852.6 38953.4 38994.8 39073.0 39455.2 7058.8 7159.8 7226.2 7245.2 7259.5 7038.3 7207.9 7211.7 7218.5 7231.5 7146.2 7220.0 7231.0 7247.5 7903.1 8057.0 8110.5 8118.6 8143.5 8154.2 7974.3 8051.8 8056.9 8070.5 8070.6 38139.0 38781.8 38860.2 39051.6 39152.6 3484.8 3540.0 3541.6 3564.9 3567.0 31667.9 32202.0 32223.0 32246.4 32417.4 5194.5 5196.7 5217.1 5220.5 5246.9 189727.0 190927.0 191242.0 191643.0 192019.0 43057.6 43971.3 47273.0 47594.5 47955.3 50267.0 50776.7 51086.2 51129.2 51158.0 14693.6 14695.8 14731.7 14818.9 14824.5 11781.7 11852.5 11874.9 11875.9 11952.0 14099.9 14119.2 14196.4 14273.8 14441.1 5592.0 5787.9 5798.2 5800.9 5854.3 988.9 1010.9 1024.2 1029.7 1037.0 23362.6 23370.8 23704.8 23849.2 23903.0 1096.9 1101.4 1111.5 1117.2 1118.9 12251.8 12415.6 12515.2 12542.9 12563.9 228391.0 228409.0 229000.0 229187.0 229760.0 51682.0 51701.0 52043.7 52714.7 52773.5 1381.9 1424.7 1446.3 1454.4 1457.1 22431.8 22928.2 23089.8 23167.0 23234.5 36477.5 36547.5 36625.3 36642.6 36670.3 187985.0 190598.0 191444.0 191491.0 191635.0 29822.3 31856.2 33690.8 33873.8 33885.7 42799.1 43282.4 43631.6 43664.3 43798.0 32403.2 32510.2 32595.2 32619.3 32901.0 31686.8 32008.5 32028.0 32682.2 32761.0 35729.6 35873.3 35884.3 36044.3 36606.3 31169.8 31591.4 31838.7 31911.0 32021.0 22844.8 23980.4 23994.6 24243.8 24393.8 07:23:10 INFO - PID 19257 | 07:23:10 INFO - PID 19257 | [#2] jquery.html Cycles:180 Average:33320.18 Median:22801.16 stddev:76364.62 (334.9%) stddev-sans-first:76539.27 07:23:10 INFO - PID 19257 | Values: 579.4 581.0 584.5 602.2 610.9 21724.9 22313.7 22324.2 22385.8 22406.6 21602.2 24272.5 24351.9 24369.4 24694.5 6340.6 6415.8 6464.4 6473.1 6475.0 6362.3 6405.6 6441.5 6451.7 6456.6 6145.4 6511.4 6525.3 6533.7 6549.7 6542.8 6567.2 6574.3 6581.0 6581.4 6092.6 6114.8 6139.2 6151.5 6164.2 27082.6 27911.6 28365.1 28531.6 28619.4 1995.7 2033.8 2034.6 2036.6 2043.1 19256.9 19456.7 19518.4 19548.0 19562.7 2371.9 2377.9 2404.5 2441.0 2459.3 124869.4 128604.4 130852.0 133435.3 135271.3 14582.7 14708.3 14842.3 14878.1 14999.3 23079.8 23093.8 23115.4 23203.8 23206.9 9087.5 9125.2 9203.8 9245.8 9251.9 7894.3 7911.7 8002.6 8048.6 8063.3 9036.2 9106.4 9111.5 9122.5 9247.9 2751.9 2768.4 2778.7 2802.4 2860.8 945.8 952.3 962.5 968.3 968.4 18859.9 18884.2 19346.8 19461.6 19626.6 1007.7 1011.6 1017.8 1018.5 1022.0 10528.0 10703.3 10823.2 10930.6 10966.6 436531.0 437194.0 448222.0 464710.0 465944.0 114157.0 114908.0 115822.4 117015.0 118874.0 1002.5 1122.8 1133.0 1191.0 1193.2 19836.0 20143.0 20200.4 20447.3 20452.7 56038.0 56162.7 57724.0 57872.7 58688.0 70357.0 72378.6 72485.0 73596.6 74059.3 14356.9 14444.9 14521.7 14570.2 14606.7 21975.6 22055.7 22083.9 22260.6 22522.5 17984.6 18058.9 18108.5 18117.9 18335.4 15789.8 16267.5 16390.0 16465.2 16523.6 17731.9 18040.4 18066.4 18261.0 18352.7 14162.1 14284.8 14284.9 14301.9 14303.4 17460.2 17871.7 17877.3 18014.7 18032.2 07:23:10 INFO - PID 19257 | 07:23:10 INFO - PID 19257 | [#3] mootools.html Cycles:180 Average:9514.21 Median:2592.80 stddev:6768.81 (261.1%) stddev-sans-first:6758.80 07:23:10 INFO - PID 19257 | Values: 1176.1 1196.1 1196.6 1202.5 1222.1 15712.8 16351.2 16415.0 16481.9 16529.8 15938.4 15963.5 16058.8 16128.8 16160.0 2777.3 2790.6 2816.8 2823.9 2824.7 2665.6 2774.0 2799.3 2801.9 2802.7 2676.6 2682.3 2696.5 2715.3 2725.1 2617.4 2623.9 2641.1 2649.6 2659.3 2574.7 2610.9 2625.0 2628.4 2640.2 15132.3 15177.2 15282.7 15293.1 15307.6 7908.6 8101.1 8332.3 8522.5 8577.4 5337.4 5522.0 5566.9 5582.9 5630.8 1925.7 1999.5 2015.7 2032.7 2044.2 24232.5 24966.6 25059.2 25681.6 25687.4 6990.9 7007.2 7245.8 7249.7 7268.3 17838.9 17978.3 17995.7 18059.2 18113.6 8103.4 8173.8 8187.5 8230.1 8236.1 7285.9 7554.5 7613.2 7743.0 7755.4 5324.3 5510.9 5580.0 5604.1 5612.2 1554.2 1586.8 1588.3 1594.6 1603.1 866.4 869.0 896.4 909.0 919.3 7622.4 7649.8 7675.7 7675.8 7694.8 714.3 736.7 739.3 743.6 750.4 5348.0 5453.9 5479.3 5581.4 5600.2 21625.5 22119.7 22385.8 22584.4 22731.0 21228.0 21783.3 22483.8 22496.3 22672.8 11068.0 11260.0 11408.2 11431.5 11504.0 8319.2 8568.9 8693.7 8707.5 8763.5 18083.0 18965.9 19081.9 19199.0 19393.0 19475.5 19599.7 20108.0 20154.4 20259.2 10985.8 11152.6 11153.9 11178.0 11257.8 13664.9 13970.3 14284.5 14408.4 14442.1 10748.7 11406.3 11510.4 11712.6 11726.6 11104.4 11487.3 11622.6 11659.8 11720.3 10075.9 10289.7 10339.2 10350.4 10397.8 7485.8 7519.2 7639.8 7667.5 7718.1 6963.8 7006.3 7051.1 7113.1 7175.5 07:23:10 INFO - PID 19257 | 07:23:10 INFO - PID 19257 | [#4] prototype.html Cycles:180 Average:5484.21 Median:6089.10 stddev:1529.44 (25.1%) stddev-sans-first:1487.24 07:23:10 INFO - PID 19257 | Values: 498.7 513.3 525.6 531.7 538.0 6021.4 6223.8 6317.4 6336.4 6392.2 5977.8 6035.3 6045.8 6162.2 6201.0 4770.5 4998.6 5000.7 5007.7 5046.8 4954.6 4961.9 4981.5 5009.6 5066.2 4910.1 4959.7 4986.8 5008.8 5020.7 4963.2 4964.5 4985.6 4993.0 5013.3 4438.0 4469.6 4488.9 4534.5 4535.6 6084.8 6093.5 6121.7 6142.3 6144.7 5701.3 5706.0 5748.3 5752.9 5764.2 6355.7 6437.9 6474.7 6509.9 6541.3 4825.9 4853.2 4862.5 4887.6 4948.8 6827.8 6904.7 6929.3 6938.4 6959.7 5079.4 5083.2 5103.4 5118.4 5121.9 5057.3 5065.9 5070.7 5087.2 5095.6 5680.4 5686.8 5729.2 5738.2 5775.6 6246.2 6422.7 6615.7 6638.8 6705.8 1605.9 1674.9 1716.8 1757.9 1763.5 1214.9 1222.2 1231.5 1265.6 1271.0 5515.2 5535.9 5577.4 5660.9 5691.9 6567.4 6577.1 6584.0 6591.4 6623.2 5550.9 5608.8 5671.7 5675.4 5689.5 3503.1 3524.6 3549.9 3577.3 3588.7 6360.8 6371.3 6424.3 6445.5 6445.7 6620.3 6649.2 6659.3 6742.3 6960.6 6368.9 6392.9 6423.5 6429.9 6492.0 6580.6 6664.6 6729.8 6737.2 6747.6 6537.5 6595.9 6667.4 6695.8 6710.5 6431.9 6442.7 6447.8 6469.8 6496.3 4935.3 5021.9 5068.4 5081.7 5089.3 6440.2 6704.4 6826.7 6869.4 6875.3 5973.6 6304.6 6345.7 6413.8 6452.9 6444.6 6467.8 6471.5 6545.6 6566.4 6370.4 6392.6 6445.4 6457.7 6482.5 6524.7 6546.8 6574.9 6647.8 6667.8 6315.5 6316.3 6335.8 6409.2 6409.5 07:23:10 INFO - PID 19257 | 07:23:10 INFO - PID 19257 | [#5] yui.html Cycles:180 Average:24974.98 Median:20255.20 stddev:36925.11 (182.3%) stddev-sans-first:36984.28 07:23:10 INFO - PID 19257 | Values: 853.3 863.9 891.1 898.8 900.6 19308.5 20226.8 20349.3 20386.0 20392.6 18252.3 18598.9 18759.4 18857.2 18969.2 936.3 961.2 962.4 964.3 966.4 971.2 974.9 978.5 983.3 984.5 1005.6 1040.6 1042.5 1045.4 1047.4 1027.5 1031.5 1031.5 1034.5 1036.2 724.2 731.4 743.7 749.0 754.5 20283.6 20491.9 20672.8 20686.2 20716.0 21629.9 22000.2 22626.8 22712.3 22770.9 17051.0 17101.7 17142.7 17278.7 17375.2 3665.6 3712.2 3718.3 3739.5 3753.6 139838.3 140299.0 141761.0 142752.3 143548.0 16902.6 17478.4 17514.3 17526.0 17540.0 31069.5 32002.7 32159.8 32496.2 33122.5 8154.0 8364.4 8425.2 8438.0 8470.3 4205.2 4213.2 4244.7 4249.8 4300.5 5410.7 5516.5 5543.0 5555.7 5571.8 1022.0 1030.4 1039.2 1044.6 1051.6 641.1 643.4 662.0 673.6 684.8 11176.3 11207.4 11250.6 11291.7 11404.0 670.0 673.3 687.4 692.1 700.0 5337.3 5370.1 5429.3 5536.1 5553.3 124964.0 127538.0 131124.0 133020.0 134197.3 112715.4 113019.4 115416.4 115737.4 119237.4 98634.0 99027.0 99167.0 99872.0 100632.5 9659.3 9774.9 10010.8 10222.2 10290.6 44983.6 46266.8 46584.0 47370.0 48016.3 59702.1 60931.0 61249.7 61312.4 62304.7 14433.4 14681.2 14721.6 14825.6 15045.6 16755.5 16926.0 16952.5 17089.6 17376.7 13345.4 13457.7 13739.1 13794.9 13886.1 16367.3 16434.5 16483.4 16504.1 16744.5 14807.3 14867.9 14964.9 14984.1 15174.8 11782.6 12051.1 12076.8 12110.4 12285.0 10714.8 10846.1 10848.4 10917.2 11009.0 07:23:10 INFO - PID 19257 | -------- Summary: end -------- 07:23:10 INFO - PID 19257 | 07:23:10 INFO - TEST-INFO | 19257: exit 0 07:23:11 INFO - TEST-OK | dromaeo_css | took 1113216ms 07:23:11 INFO - TEST-START | kraken 07:23:11 INFO - Initialising browser for kraken test... 07:23:11 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59449/getInfo.html -profile /tmp/tmpW4Db9p/profile 07:23:11 INFO - TEST-INFO | started process 19643 (/builds/slave/test/build/application/firefox/firefox http://localhost:59449/getInfo.html) 07:23:16 INFO - TEST-INFO | 19643: exit 0 07:23:17 INFO - Browser initialized. 07:23:17 INFO - Running cycle 1/1 for kraken test... 07:23:17 INFO - Using env: {'DISPLAY': ':0', 07:23:17 INFO - 'HOME': '/home/cltbld', 07:23:17 INFO - 'JSGC_DISABLE_POISONING': '1', 07:23:17 INFO - 'LANG': 'en_US.UTF-8', 07:23:17 INFO - 'LANGUAGE': 'en_US:en', 07:23:17 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 07:23:17 INFO - 'LOGNAME': 'cltbld', 07:23:17 INFO - 'MAIL': '/var/mail/cltbld', 07:23:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:23:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:23:17 INFO - 'MOZ_ACCELERATED': '1', 07:23:17 INFO - 'MOZ_CRASHREPORTER': '1', 07:23:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:17 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 07:23:17 INFO - 'MOZ_NO_REMOTE': '1', 07:23:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:23:17 INFO - 'MOZ_WEBRENDER': '1', 07:23:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:23:17 INFO - 'NO_EM_RESTART': '1', 07:23:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:23:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:17 INFO - 'PWD': '/builds/slave/test', 07:23:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:23:17 INFO - 'RUST_BACKTRACE': 'full', 07:23:17 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:23:17 INFO - 'SHELL': '/bin/bash', 07:23:17 INFO - 'SHLVL': '1', 07:23:17 INFO - 'TERM': 'linux', 07:23:17 INFO - 'TMOUT': '86400', 07:23:17 INFO - 'USER': 'cltbld', 07:23:17 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1506002182.263489-733130944', 07:23:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:17 INFO - '_': '/tools/buildbot/bin/python'} 07:23:17 INFO - TEST-INFO | started process 19894 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW4Db9p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:23:17 INFO - PID 19894 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 07:23:18 INFO - PID 19894 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 07:23:18 INFO - PID 19894 | 07:23:18 INFO - PID 19894 | (/builds/slave/test/build/application/firefox/firefox:19954): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:23:18 INFO - PID 19894 | 07:23:28 INFO - PID 19894 | RSS: Main: 207122432 07:23:28 INFO - PID 19894 | 07:23:31 INFO - PID 19894 | Cycle 1(1): loaded http://localhost:59449/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59449/tests/kraken/driver.html?testName=audio-beat-detection) 07:23:32 INFO - PID 19894 | RSS: Main: 207360000 07:23:32 INFO - PID 19894 | 07:23:35 INFO - PID 19894 | Cycle 1(1): loaded http://localhost:59449/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59449/tests/kraken/driver.html?testName=audio-dft) 07:23:35 INFO - PID 19894 | RSS: Main: 207994880 07:23:35 INFO - PID 19894 | 07:23:38 INFO - PID 19894 | Cycle 1(1): loaded http://localhost:59449/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59449/tests/kraken/driver.html?testName=audio-fft) 07:23:39 INFO - PID 19894 | RSS: Main: 204345344 07:23:39 INFO - PID 19894 | 07:23:41 INFO - PID 19894 | Cycle 1(1): loaded http://localhost:59449/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59449/tests/kraken/driver.html?testName=audio-oscillator) 07:23:42 INFO - PID 19894 | RSS: Main: 206098432 07:23:42 INFO - PID 19894 | 07:23:44 INFO - PID 19894 | Cycle 1(1): loaded http://localhost:59449/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59449/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:23:45 INFO - PID 19894 | RSS: Main: 204898304 07:23:45 INFO - PID 19894 | 07:23:48 INFO - PID 19894 | Cycle 1(1): loaded http://localhost:59449/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59449/tests/kraken/driver.html?testName=imaging-darkroom) 07:23:48 INFO - PID 19894 | RSS: Main: 207912960 07:23:48 INFO - PID 19894 | 07:23:52 INFO - PID 19894 | Cycle 1(1): loaded http://localhost:59449/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59449/tests/kraken/driver.html?testName=imaging-desaturate) 07:23:53 INFO - PID 19894 | RSS: Main: 208285696 07:23:53 INFO - PID 19894 | 07:23:56 INFO - PID 19894 | Cycle 1(1): loaded http://localhost:59449/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59449/tests/kraken/driver.html?testName=json-parse-financial) 07:23:56 INFO - PID 19894 | RSS: Main: 208560128 07:23:56 INFO - PID 19894 | 07:23:58 INFO - PID 19894 | Cycle 1(1): loaded http://localhost:59449/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59449/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:23:59 INFO - PID 19894 | RSS: Main: 209915904 07:23:59 INFO - PID 19894 | 07:24:00 INFO - PID 19894 | Cycle 1(1): loaded http://localhost:59449/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59449/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:24:01 INFO - PID 19894 | RSS: Main: 205582336 07:24:01 INFO - PID 19894 | 07:24:03 INFO - PID 19894 | Cycle 1(1): loaded http://localhost:59449/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59449/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:24:04 INFO - PID 19894 | RSS: Main: 206544896 07:24:04 INFO - PID 19894 | 07:24:06 INFO - PID 19894 | Cycle 1(1): loaded http://localhost:59449/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59449/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:24:07 INFO - PID 19894 | RSS: Main: 206626816 07:24:07 INFO - PID 19894 | 07:24:10 INFO - PID 19894 | Cycle 1(1): loaded http://localhost:59449/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59449/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:24:11 INFO - PID 19894 | RSS: Main: 205967360 07:24:11 INFO - PID 19894 | 07:24:12 INFO - PID 19894 | Cycle 1(1): loaded http://localhost:59449/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59449/tests/kraken/driver.html?testName=ai-astar) 07:24:13 INFO - PID 19894 | RSS: Main: 208486400 07:24:13 INFO - PID 19894 | 07:24:13 INFO - PID 19894 | __start_tp_report 07:24:13 INFO - PID 19894 | _x_x_mozilla_page_load 07:24:13 INFO - PID 19894 | _x_x_mozilla_page_load_details 07:24:13 INFO - PID 19894 | |i|pagename|runs| 07:24:13 INFO - PID 19894 | |0;ai-astar;111;113;107;109;108;106;106;113;108;107 07:24:13 INFO - PID 19894 | |1;audio-beat-detection;125;120;126;128;120;124;119;152;120;120 07:24:13 INFO - PID 19894 | |2;audio-dft;169;164;164;163;173;180;163;165;174;174 07:24:13 INFO - PID 19894 | |3;audio-fft;85;79;77;75;80;75;80;75;79;78 07:24:13 INFO - PID 19894 | |4;audio-oscillator;80;85;80;88;82;80;83;91;86;85 07:24:13 INFO - PID 19894 | |5;imaging-gaussian-blur;113;115;114;115;115;112;114;116;127;116 07:24:13 INFO - PID 19894 | |6;imaging-darkroom;148;150;153;149;152;150;152;149;151;150 07:24:13 INFO - PID 19894 | |7;imaging-desaturate;99;95;101;97;94;95;97;101;94;96 07:24:13 INFO - PID 19894 | |8;json-parse-financial;56;55;54;52;54;56;54;53;54;54 07:24:13 INFO - PID 19894 | |9;json-stringify-tinderbox;39;45;38;48;50;39;39;44;47;38 07:24:13 INFO - PID 19894 | |10;stanford-crypto-aes;78;79;78;75;81;83;74;82;76;74 07:24:13 INFO - PID 19894 | |11;stanford-crypto-ccm;119;116;123;116;116;115;115;113;126;121 07:24:13 INFO - PID 19894 | |12;stanford-crypto-pbkdf2;173;170;179;169;167;166;175;172;180;172 07:24:13 INFO - PID 19894 | |13;stanford-crypto-sha256-iterative;68;66;64;65;71;66;64;64;65;66 07:24:13 INFO - PID 19894 | __end_tp_report 07:24:13 INFO - PID 19894 | __start_cc_report 07:24:13 INFO - PID 19894 | _x_x_mozilla_cycle_collect,751 07:24:13 INFO - PID 19894 | __end_cc_report 07:24:13 INFO - PID 19894 | __startTimestamp1506003853145__endTimestamp 07:24:13 INFO - PID 19894 | 07:24:13 INFO - PID 19894 | ------- Summary: start ------- 07:24:13 INFO - PID 19894 | Number of tests: 14 07:24:13 INFO - PID 19894 | 07:24:13 INFO - PID 19894 | [#0] ai-astar Cycles:10 Average:108.80 Median:108.50 stddev:2.66 (2.5%) stddev-sans-first:2.70 07:24:13 INFO - PID 19894 | Values: 111.0 113.0 107.0 109.0 108.0 106.0 106.0 113.0 108.0 107.0 07:24:13 INFO - PID 19894 | 07:24:13 INFO - PID 19894 | [#1] audio-beat-detection Cycles:10 Average:125.40 Median:124.50 stddev:9.86 (7.9%) stddev-sans-first:10.45 07:24:13 INFO - PID 19894 | Values: 125.0 120.0 126.0 128.0 120.0 124.0 119.0 152.0 120.0 120.0 07:24:13 INFO - PID 19894 | 07:24:13 INFO - PID 19894 | [#2] audio-dft Cycles:10 Average:168.90 Median:171.00 stddev:6.01 (3.5%) stddev-sans-first:6.37 07:24:13 INFO - PID 19894 | Values: 169.0 164.0 164.0 163.0 173.0 180.0 163.0 165.0 174.0 174.0 07:24:13 INFO - PID 19894 | 07:24:13 INFO - PID 19894 | [#3] audio-fft Cycles:10 Average:78.30 Median:79.00 stddev:3.09 (3.9%) stddev-sans-first:2.13 07:24:13 INFO - PID 19894 | Values: 85.0 79.0 77.0 75.0 80.0 75.0 80.0 75.0 79.0 78.0 07:24:13 INFO - PID 19894 | 07:24:13 INFO - PID 19894 | [#4] audio-oscillator Cycles:10 Average:84.00 Median:85.00 stddev:3.71 (4.4%) stddev-sans-first:3.64 07:24:13 INFO - PID 19894 | Values: 80.0 85.0 80.0 88.0 82.0 80.0 83.0 91.0 86.0 85.0 07:24:13 INFO - PID 19894 | 07:24:13 INFO - PID 19894 | [#5] imaging-gaussian-blur Cycles:10 Average:115.70 Median:115.00 stddev:4.16 (3.6%) stddev-sans-first:4.30 07:24:13 INFO - PID 19894 | Values: 113.0 115.0 114.0 115.0 115.0 112.0 114.0 116.0 127.0 116.0 07:24:13 INFO - PID 19894 | 07:24:13 INFO - PID 19894 | [#6] imaging-darkroom Cycles:10 Average:150.40 Median:150.50 stddev:1.58 (1.0%) stddev-sans-first:1.41 07:24:13 INFO - PID 19894 | Values: 148.0 150.0 153.0 149.0 152.0 150.0 152.0 149.0 151.0 150.0 07:24:13 INFO - PID 19894 | 07:24:13 INFO - PID 19894 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:95.50 stddev:2.64 (2.8%) stddev-sans-first:2.69 07:24:13 INFO - PID 19894 | Values: 99.0 95.0 101.0 97.0 94.0 95.0 97.0 101.0 94.0 96.0 07:24:13 INFO - PID 19894 | 07:24:13 INFO - PID 19894 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.00 stddev:1.23 (2.3%) stddev-sans-first:1.12 07:24:13 INFO - PID 19894 | Values: 56.0 55.0 54.0 52.0 54.0 56.0 54.0 53.0 54.0 54.0 07:24:13 INFO - PID 19894 | 07:24:13 INFO - PID 19894 | [#9] json-stringify-tinderbox Cycles:10 Average:42.70 Median:44.50 stddev:4.62 (10.4%) stddev-sans-first:4.70 07:24:13 INFO - PID 19894 | Values: 39.0 45.0 38.0 48.0 50.0 39.0 39.0 44.0 47.0 38.0 07:24:13 INFO - PID 19894 | 07:24:13 INFO - PID 19894 | [#10] stanford-crypto-aes Cycles:10 Average:78.00 Median:78.50 stddev:3.27 (4.2%) stddev-sans-first:3.46 07:24:13 INFO - PID 19894 | Values: 78.0 79.0 78.0 75.0 81.0 83.0 74.0 82.0 76.0 74.0 07:24:13 INFO - PID 19894 | 07:24:13 INFO - PID 19894 | [#11] stanford-crypto-ccm Cycles:10 Average:118.00 Median:117.50 stddev:4.14 (3.5%) stddev-sans-first:4.37 07:24:13 INFO - PID 19894 | Values: 119.0 116.0 123.0 116.0 116.0 115.0 115.0 113.0 126.0 121.0 07:24:13 INFO - PID 19894 | 07:24:13 INFO - PID 19894 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.30 Median:172.50 stddev:4.67 (2.7%) stddev-sans-first:4.94 07:24:13 INFO - PID 19894 | Values: 173.0 170.0 179.0 169.0 167.0 166.0 175.0 172.0 180.0 172.0 07:24:13 INFO - PID 19894 | 07:24:13 INFO - PID 19894 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:2.18 (3.3%) stddev-sans-first:2.18 07:24:13 INFO - PID 19894 | Values: 68.0 66.0 64.0 65.0 71.0 66.0 64.0 64.0 65.0 66.0 07:24:13 INFO - PID 19894 | -------- Summary: end -------- 07:24:13 INFO - PID 19894 | 07:24:13 INFO - PID 19894 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 07:24:14 INFO - TEST-INFO | 19894: exit 0 07:24:14 INFO - TEST-OK | kraken | took 63261ms 07:24:14 INFO - SUITE-END | took 1176s 07:24:14 INFO - Completed test suite (00:19:36) 07:24:14 INFO - javascript benchmark 07:24:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8465.246136785263, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3078.7383072438843, 3089.7682673799472, 3107.06787963611, 3129.2333378322314, 3145.6539780624125, 6032.185654936582, 6176.722047507862, 6242.5630205885545, 6273.996160614302, 6327.955887278599, 6192.287886893008, 6203.844903877405, 6246.500279977602, 6310.305866354697, 6324.7470101195895, 5694.430556944314, 5742.196092547047, 5744.253247077884, 5769.249997500319, 5852.0, 5828.242328497311, 5838.708064596774, 5852.941470585282, 5891.8527036824, 5948.970255148718, 1343.827507069617, 5848.0, 5856.76572937082, 5926.496247818941, 5939.1388248703915, 5722.0, 5743.684097374643, 5779.855503612402, 5834.824955251349, 5879.79420720277, 5687.800926967578, 5769.5672824537905, 5813.6221145625395, 5826.679532625704, 5845.941540584625, 6212.378762123752, 6282.87434251317, 6284.34014428483, 6335.334789847046, 6411.070394792776, 6655.367740064686, 6756.93243067568, 6769.0861733665815, 6790.354916282995, 6816.318368163194, 6792.21889482706, 6839.179298484214, 6886.0, 6887.7244910203535, 6917.619530925797, 6102.786402475892, 6199.0, 6214.65819379934, 6241.063840423927, 6258.561900667, 6788.389044985975, 6849.452043836481, 6868.965655171792, 6880.724771009103, 6896.620685862325, 6538.0, 6586.670666466657, 6658.5671931324305, 6673.1992160941, 6713.0, 6679.432248258952, 6697.8995315070315, 6704.229013663394, 6728.360805723449, 6730.360615741497, 6726.7981960541265, 6749.595024298558, 6777.457803375718, 6810.489213309022, 6819.079424277659, 6479.481641468766, 6698.8995165072565, 6713.56361836479, 6729.730810767514, 6823.215330236987, 5261.079311120615, 5287.9735601321745, 5293.57651387888, 5308.283381743492, 5308.548773354308, 4480.171168333869, 4558.407407037064, 4581.931271030937, 4588.357629931812, 4610.585047345755, 5821.09772985188, 5835.854103647443, 5843.883122337615, 5880.8235752927485, 5883.17635531026, 6821.727130914807, 6831.419329357061, 6837.247902730695, 6878.65606719662, 6922.688479018456, 5636.379998200195, 5783.595148339576, 5821.27234095738, 5863.120531920161, 5867.266591676041, 5668.7165641718575, 5708.20085188074, 5733.168690539848, 5743.655380677173, 5750.02249617566, 6428.325025872309, 6487.870242595121, 6525.282218955911, 6563.7702680405955, 6569.605823650596, 6755.898661520179, 6781.287964763629, 6784.457243420515, 6789.287124852017, 6866.382025617719, 6512.0, 6530.869382612226, 6604.14146160996, 6610.8016759497295, 6622.8344291393105, 6414.743410263537, 6529.804105876831, 6645.0, 6721.731130754715, 6733.966330168514, 6714.865702686016, 6724.865502690017, 6726.461883049246, 6776.119104516381, 6786.728530858908, 6447.677616119269, 6470.029495575702, 6512.902306465501, 6531.281559028408, 6583.967080164569, 6618.172728408949, 6625.271220165874, 6641.568298060611, 6687.799366019027, 6687.899681504879, 6422.293547709654, 6483.384078512534, 6501.382368674968, 6563.0, 6575.967120164369, 6459.386358295955, 6478.838029049311, 6588.308227636221, 6642.634655094016, 6679.332066793476, 6349.746010159727, 6414.807555773335, 6433.678316084083, 6434.06706027614, 6470.870582588416], "value": 6105.733634512015, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [870.4994628088849, 882.5984177199375, 884.2351366068351, 885.5439448683925, 892.8749975003501, 38078.23843523128, 41733.0, 41927.79036104823, 42026.789866050705, 42183.36724949128, 38852.611473885256, 38953.41569876454, 38994.80502597483, 39073.0, 39455.21089578207, 7058.823529411755, 7159.821004474904, 7226.205117437078, 7245.203027666952, 7259.455540834432, 7038.26098259683, 7207.89188162178, 7211.711531538732, 7218.458615603825, 7231.529950553224, 7146.178189508221, 7219.963900180518, 7231.023811785421, 7247.492675512716, 7903.130655627905, 8057.033156021285, 8110.472819266729, 8118.63466144019, 8143.470674406145, 8154.184581541857, 7974.322182614426, 8051.798705032421, 8056.879146812803, 8070.47541909774, 8070.55611941343, 38139.0, 38781.80609096964, 38860.22279554393, 39051.60948390508, 39152.60847391518, 3484.756067075306, 3539.964600354015, 3541.6458354164633, 3564.928701425957, 3567.0369000369756, 31667.891623793286, 32202.0, 32223.0, 32246.355072898645, 32417.351652967045, 5194.480551944813, 5196.662216955886, 5217.139172036609, 5220.504052115043, 5246.8688282792855, 189727.0, 190927.0, 191242.0, 191643.0, 192019.03990479957, 43057.56942430536, 43971.34042989358, 47273.0, 47594.5240547597, 47955.280670789965, 50267.0, 50776.74611626992, 51086.23370649443, 51129.23306150411, 51157.953681853054, 14693.55919322422, 14695.77956330656, 14731.705365892622, 14818.851811481964, 14824.481143159937, 11781.705457363634, 11852.466639001266, 11874.881251187551, 11875.88124118765, 11952.0, 14099.929500352433, 14119.152850828983, 14196.432142714382, 14273.785893211403, 14441.06133101345, 5591.993441180626, 5787.913181302284, 5798.188253644493, 5800.941990580124, 5854.297484301911, 988.8763904511936, 1010.9191264698807, 1024.1908891975404, 1029.6807989523272, 1037.0355569320604, 23362.64956025661, 23370.831458427012, 23704.762952370256, 23849.165279215144, 23903.0, 1096.873859506167, 1101.388729255271, 1111.4942701070993, 1117.212365282474, 1118.8657361116718, 12251.816222756666, 12415.565455209024, 12515.249085054926, 12542.937285313697, 12563.937180314222, 228391.0, 228409.0, 229000.0, 229187.0, 229760.0, 51682.0, 51701.0, 52043.73978130085, 52714.73642631839, 52773.472265277625, 1381.896357773171, 1424.7150569886064, 1446.3274577321597, 1454.403694485256, 1457.103881113129, 22431.77568224297, 22928.19751308696, 23089.845507724884, 23167.0, 23234.53530929338, 36477.45283820798, 36547.45178822373, 36625.26749465049, 36642.633573664985, 36670.266594667424, 187985.0, 190598.0, 191444.0, 191491.0, 191635.0, 29822.25444363908, 31856.203594910312, 33690.83154584211, 33873.830630846685, 33885.66114338825, 42799.1440171201, 43282.35076473792, 43631.56368436275, 43664.345034825135, 43798.0, 32403.18992025218, 32510.187245319055, 32595.18512037218, 32619.34761304808, 32901.0, 31686.841565792023, 32008.5198722024, 32028.03915882527, 32682.182945426553, 32761.0, 35729.64270357367, 35873.28253434865, 35884.28231435409, 36044.27911441704, 36606.267874641824, 31169.8441507791, 31591.368172636878, 31838.681613183573, 31911.0, 32021.0, 22844.771552284263, 23980.40048998719, 23994.64810811587, 24243.75756242415, 24393.756062439148], "value": 16990.330560196107, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.3627010288683, 580.973856176472, 584.5206930317139, 602.2411761180912, 610.9480694140997, 21724.89137554312, 22313.665295020586, 22324.218652347172, 22385.776142238614, 22406.55186896263, 21602.243921462752, 24272.514549709038, 24351.878240608774, 24369.390765230877, 24694.50610987779, 6340.587861788992, 6415.8396040098905, 6464.385883341075, 6473.126127972734, 6474.9676251618675, 6362.268339140988, 6405.615663060208, 6441.549091563593, 6451.7096730647, 6456.58032227906, 6145.385461453863, 6511.413972742453, 6525.347465253484, 6533.673316334188, 6549.738010479575, 6542.7710030148955, 6567.211934567882, 6574.276829548746, 6581.045748366508, 6581.3747693969235, 6092.573519853612, 6114.816555503342, 6139.201903752528, 6151.5386346024225, 6164.229471316085, 27082.593761093598, 27911.58132628012, 28365.149045528666, 28531.57202641962, 28619.427611447863, 1995.7006449032617, 2033.8169564739244, 2034.5930813837144, 2036.6334059869218, 2043.0704029666465, 19256.903715481472, 19456.70814937777, 19518.414447566596, 19548.0, 19562.70655940162, 2371.9288421347214, 2377.8811059446957, 2404.507076049406, 2441.011390386896, 2459.2622213335926, 124869.37565312206, 128604.35697821545, 130852.0, 133435.33282333624, 135271.32364338214, 14582.702643685643, 14708.33812478441, 14842.257887105601, 14878.07315610625, 14999.250037498081, 23079.769202308096, 23093.769062309497, 23115.422114447272, 23203.767962320497, 23206.883965580066, 9087.545622718837, 9125.17873391398, 9203.815923681488, 9245.768855778659, 9251.90748092524, 7894.289513943772, 7911.723089691834, 8002.5998700064765, 8048.637811298506, 8063.314618257396, 9036.186743193144, 9106.362554621246, 9111.537615705989, 9122.543872806466, 9247.907520924704, 2751.917442476729, 2768.418632087244, 2778.652668416448, 2802.369466869938, 2860.8140470869325, 945.8013817098349, 952.3095755577151, 962.4658314635444, 968.2592816495387, 968.4286271100085, 18859.86840789557, 18884.24463021491, 19346.8065319345, 19461.610767784565, 19626.607467850565, 1007.7027276953316, 1011.610529945976, 1017.7811770469236, 1018.4551265073151, 1021.9897801021895, 10528.0, 10703.250772445854, 10823.188260880466, 10930.56277748881, 10966.561337546409, 436531.0, 437194.0, 448222.0, 464710.0, 465944.0, 114157.0, 114908.0, 115822.4208878967, 117015.0, 118874.0, 1002.4987506246877, 1122.825961975895, 1132.9886701133048, 1191.0471622701978, 1193.230366413641, 19836.0, 20143.0, 20200.393988180378, 20447.28434504785, 20452.693209602166, 56038.0, 56162.7191864038, 57724.0, 57872.71063644823, 58688.0, 70357.0, 72378.63810681124, 72485.0, 73596.63201683958, 74059.25940740739, 14356.85643143597, 14444.927775361057, 14521.709565808413, 14570.198639074528, 14606.707865842836, 21975.560488790456, 22055.66916496222, 22083.895805209355, 22260.554788904454, 22522.549549009254, 17984.550386239924, 18058.909705451388, 18108.547286317946, 18117.909410452863, 18335.35826246075, 15789.842101578837, 16267.51197464078, 16390.0, 16465.176741163134, 16523.586910327336, 17731.911340443214, 18040.368587099387, 18066.36767713124, 18261.0, 18352.724709129106, 14162.079464834753, 14284.785728213878, 14284.928575357057, 14301.856981430052, 14303.427862885368, 17460.21429035671, 17871.73192402141, 17877.28490860403, 18014.72977905306, 18032.188551515475], "value": 11750.486006451976, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1176.053277111925, 1196.1387800783432, 1196.6290449960513, 1202.518992403039, 1222.1261797814554, 15712.842871571294, 16351.182440877938, 16415.0, 16481.917590412046, 16529.83470165298, 15938.442154524593, 15963.521094367188, 16058.83941160588, 16128.83871161288, 16160.0, 2777.3334399744017, 2790.595363672266, 2816.788740844445, 2823.9435211295763, 2824.6751623563246, 2665.6134860445222, 2774.0429551804696, 2799.258196577898, 2801.90193343233, 2802.6776920654183, 2676.5583678693088, 2682.2757855379036, 2696.4876673431986, 2715.3483164040586, 2725.1007167634734, 2617.3718307606227, 2623.908163214288, 2641.141628970573, 2649.576067829138, 2659.3085797692643, 2574.742525747429, 2610.85640289784, 2625.0024990503675, 2628.3823301524317, 2640.234332043705, 15132.319045642973, 15177.24113794306, 15282.694346113016, 15293.082415055133, 15307.617309567238, 7908.565028923407, 8101.149379315146, 8332.250097491195, 8522.531260780655, 8577.356698247657, 5337.412884582693, 5522.0336441122645, 5566.860828479321, 5582.944170558283, 5630.774769009235, 1925.682262426698, 1999.530110424049, 2015.7077223802612, 2032.6768349869253, 2044.2334124703236, 24232.515349693083, 24966.625500617505, 25059.248222553353, 25681.614775778376, 25687.357816054748, 6990.882929070678, 7007.229204787469, 7245.7826265212125, 7249.710011599583, 7268.273172682795, 17838.91080544615, 17978.280868765363, 17995.73006404905, 18059.187336569885, 18113.637727245383, 8103.351731861437, 8173.795655108551, 8187.5087494750505, 8230.135835737281, 8236.052853921756, 7285.927140728631, 7554.508956917783, 7613.200613935568, 7742.961285193538, 7755.379569634416, 5324.254604355393, 5510.9448905510435, 5580.0, 5604.131359639263, 5612.158176273591, 1554.207354249341, 1586.8413158684039, 1588.269396077794, 1594.609320716432, 1603.0862408427085, 866.4498043742269, 868.9608967596473, 896.4352457951579, 908.9863652045225, 919.2645883293338, 7622.390208783284, 7649.77603583424, 7675.731349402856, 7675.769726908202, 7694.769156925301, 714.310690183975, 736.731093150996, 739.3456790740127, 743.6170372258291, 750.4184257200714, 5348.0, 5453.918191227135, 5479.260299859548, 5581.441855814467, 5600.159976003551, 21625.459363516038, 22119.668204976617, 22385.776142238694, 22584.435389115402, 22731.0, 21228.0, 21783.34649960504, 22483.775162248166, 22496.32511024672, 22672.773272267066, 11068.0, 11260.0, 11408.201425900274, 11431.485583148778, 11504.022158116653, 8319.209675080858, 8568.871466928125, 8693.739187824376, 8707.47755134694, 8763.518006509703, 18083.0, 18965.90517047406, 19081.90459047696, 19199.0, 19393.0, 19475.513112171742, 19599.70600440966, 20108.0, 20154.39536813898, 20259.18963241454, 10985.835212471979, 11152.609658661908, 11153.944230279121, 11178.0, 11257.831132532854, 13664.93167534156, 13970.30148492551, 14284.500042498463, 14408.42366305336, 14442.133471991714, 10748.677539673823, 11406.258593191416, 11510.36692981894, 11712.590059347882, 11726.589569365031, 11104.444777760918, 11487.310761354345, 11622.593209237637, 11659.76680466369, 11720.300556419443, 10075.949620251851, 10289.691309260734, 10339.22455815832, 10350.378977261389, 10397.844032339672, 7485.7754267372065, 7519.248075192656, 7639.847203055797, 7667.46327757074, 7718.073831140075, 6963.825904352229, 7006.299370062953, 7051.083359163276, 7113.110861142357, 7175.461840362098], "value": 6731.004269164317, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.6509443389626, 513.2737176894694, 525.5509326538331, 531.7474199755119, 537.9892402151957, 6021.367756385582, 6223.844403889893, 6317.36826317368, 6336.398042185991, 6392.200974878146, 5977.790777322794, 6035.305939816923, 6045.818625441233, 6162.168107305512, 6201.0, 4770.522947705219, 4998.57512111471, 5000.7249601271915, 5007.699538027712, 5046.82336118236, 4954.554090131887, 4961.883576195363, 4981.526754958273, 5009.649324547283, 5066.1640829263315, 4910.140725373063, 4959.677620954644, 4986.75066246688, 5008.824691135811, 5020.748962551857, 4963.1636294571235, 4964.485831821293, 4985.626078044161, 4992.975035124819, 5013.348264725562, 4438.0, 4469.597736203725, 4488.932666010012, 4534.478534968488, 4535.614472769818, 6084.756609735649, 6093.451589356979, 6121.724522396503, 6142.324344322121, 6144.723487443076, 5701.25883635129, 5705.971470142623, 5748.2527271454865, 5752.879936856201, 5764.164196191528, 6355.650439225841, 6437.903431448532, 6474.741010359627, 6509.934900651027, 6541.28045914949, 4825.879353016167, 4853.199222128344, 4862.513748625144, 4887.584555312803, 4948.802047918079, 6827.829304267433, 6904.689288982008, 6929.272426395206, 6938.444924406086, 6959.721611135599, 5079.4412614612365, 5083.204237669267, 5103.362079740033, 5118.360204974379, 5121.948780512222, 5057.342545469065, 5065.898682026339, 5070.7464626768515, 5087.186050231945, 5095.566876815438, 5680.4319568042865, 5686.800961966312, 5729.221327656083, 5738.225339579187, 5775.595708300379, 6246.187995560548, 6422.678866056678, 6615.702293396808, 6638.805015097232, 6705.798826035227, 1605.855473007435, 1674.8610944557574, 1716.8025677047049, 1757.885737427063, 1763.4621440460783, 1214.908881833866, 1222.2177806204036, 1231.4581584102966, 1265.639292801547, 1270.9555165569345, 5515.172724091338, 5535.889282214333, 5577.386487486373, 5660.8867822643315, 5691.9146212806845, 6567.376099270562, 6577.14497115372, 6584.012398140221, 6591.43972762311, 6623.205215374186, 5550.888982220333, 5608.803691870765, 5671.716414179357, 5675.432456754292, 5689.516391106719, 3503.1417302760988, 3524.5770507538746, 3549.911252218715, 3577.284543091392, 3588.7308451866215, 6360.77737279193, 6371.299157092716, 6424.293327733945, 6445.45213656835, 6445.742170313229, 6620.304867988888, 6649.235337936103, 6659.267480577133, 6742.325767423218, 6960.582365058112, 6368.936310636927, 6392.904106438407, 6423.454006409414, 6429.935700642934, 6492.0, 6580.5722628029025, 6664.566803157779, 6729.831754206184, 6737.225219099866, 6747.628880411625, 6537.5484193427465, 6595.934040659532, 6667.43326817226, 6695.799126026032, 6710.496712746466, 6431.903521447276, 6442.742290308335, 6447.806565803034, 6469.838254043687, 6496.252930913006, 4935.333729946411, 5021.874453138701, 5068.417132029864, 5081.669691470042, 5089.338386009795, 6440.227172739301, 6704.4301234395625, 6826.658667066726, 6869.416099631388, 6875.349916020019, 5973.611715238496, 6304.590201636879, 6345.7144428499905, 6413.839654008687, 6452.870942581216, 6444.581102228341, 6467.773627923, 6471.514636402195, 6545.574537655038, 6566.4418524425955, 6370.394812492806, 6392.584482008655, 6445.387688169616, 6457.67711614408, 6482.513811464065, 6524.739010439529, 6546.770863019771, 6574.901376479261, 6647.800565983028, 6667.799966001027, 6315.463185629089, 6316.305206427382, 6335.841603959938, 6409.230892292955, 6409.487241020801], "value": 5036.263059722893, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [853.3216093205901, 863.9416714524704, 891.1133422244867, 898.7842917699754, 900.5902314446923, 19308.51728706783, 20226.797732022675, 20349.28777492788, 20386.0, 20392.59214815703, 18252.26990920365, 18598.90700546499, 18759.43721688348, 18857.15142818573, 18969.24123035077, 936.2790651198573, 961.1589858873485, 962.3600305796672, 964.2671569607114, 966.3766870368609, 971.2230215827345, 974.9470571782458, 978.496074521622, 983.2625530851861, 984.5274268351196, 1005.5525291245399, 1040.6357774778842, 1042.47876061969, 1045.3988956350129, 1047.4239168457357, 1027.4862568715641, 1031.4791030529534, 1031.4894127406944, 1034.5034383495927, 1036.1917704190744, 724.2178447276981, 731.3783284208433, 743.680217506472, 748.9737859174903, 754.4944886925718, 20283.594328113355, 20491.897540512353, 20672.793272067236, 20686.172553098007, 20716.0, 21629.891850540647, 22000.229991950364, 22626.77373226263, 22712.318630441114, 22770.886145569333, 17051.0, 17101.657966840594, 17142.742858857127, 17278.65442691139, 17375.218115184845, 3665.6334366563397, 3712.201876596545, 3718.2749363874054, 3739.495168152319, 3753.5871054184017, 139838.30080849634, 140299.0, 141761.0, 142752.28623856918, 143548.0, 16902.57743556421, 17478.388256411217, 17514.29942802299, 17526.0, 17540.0, 31069.533956990665, 32002.679973200437, 32159.839200803846, 32496.187595309835, 33122.50316245258, 8154.0, 8364.414490985695, 8425.199606037417, 8437.95781021091, 8470.280026197843, 4205.201011807808, 4213.241616509058, 4244.745315281093, 4249.766262855511, 4300.483941926988, 5410.702411367412, 5516.531094856902, 5542.97228513863, 5555.666660000413, 5571.832845014656, 1021.9795604087876, 1030.3611760708409, 1039.1634734039171, 1044.639599338227, 1051.5530899367739, 641.0992555459587, 643.411278680012, 661.966901654925, 673.619405036153, 684.8424862281703, 11176.27354221973, 11207.38359390225, 11250.642872479008, 11291.661250162344, 11404.030657394049, 669.9765508207287, 673.2795908377989, 687.4363022321648, 692.1452006771633, 699.9615021173782, 5337.2794672719465, 5370.113931201387, 5429.267048948421, 5536.114221724505, 5553.278073850373, 124964.0, 127538.0, 131124.0, 133020.0, 134197.32901335432, 112715.43642281737, 113019.43490282496, 115416.42291788488, 115737.4213128929, 119237.40381298211, 98634.0, 99027.0, 99167.0, 99872.0, 100632.49683751681, 9659.275554333593, 9774.85337719949, 10010.799784004425, 10222.233332499944, 10290.639827605997, 44983.55016449794, 46266.76866615645, 46584.0, 47370.0, 48016.27975580439, 59702.10446843388, 60931.0, 61249.69375153274, 61312.386876132456, 62304.68847655733, 14433.35049922735, 14681.19253441071, 14721.631959201106, 14825.555233343017, 15045.623859403602, 16755.497335079966, 16926.0, 16952.491425257263, 17089.572760681083, 17376.652466950844, 13345.399457024652, 13457.663558410726, 13739.106958047694, 13794.862051379358, 13886.09740366873, 16367.263473143976, 16434.506964791075, 16483.423080192137, 16504.092274924995, 16744.497665070066, 14807.333669985092, 14867.92566037163, 14964.850351496782, 14984.100953942798, 15174.848251517344, 11782.646520604396, 12051.096167787626, 12076.758464830478, 12110.35542670661, 12285.0, 10714.785704286027, 10846.13230941507, 10848.403337816495, 10917.23579349438, 11009.0], "value": 8904.886877991412, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1459.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 107.0, 109.0, 108.0, 106.0, 106.0, 113.0, 108.0, 107.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 120.0, 126.0, 128.0, 120.0, 124.0, 119.0, 152.0, 120.0, 120.0], "value": 125.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 164.0, 164.0, 163.0, 173.0, 180.0, 163.0, 165.0, 174.0, 174.0], "value": 168.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 79.0, 77.0, 75.0, 80.0, 75.0, 80.0, 75.0, 79.0, 78.0], "value": 78.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 85.0, 80.0, 88.0, 82.0, 80.0, 83.0, 91.0, 86.0, 85.0], "value": 84.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 114.0, 115.0, 115.0, 112.0, 114.0, 116.0, 127.0, 116.0], "value": 115.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 150.0, 153.0, 149.0, 152.0, 150.0, 152.0, 149.0, 151.0, 150.0], "value": 150.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 95.0, 101.0, 97.0, 94.0, 95.0, 97.0, 101.0, 94.0, 96.0], "value": 96.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 54.0, 52.0, 54.0, 56.0, 54.0, 53.0, 54.0, 54.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 45.0, 38.0, 48.0, 50.0, 39.0, 39.0, 44.0, 47.0, 38.0], "value": 42.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 78.0, 75.0, 81.0, 83.0, 74.0, 82.0, 76.0, 74.0], "value": 78.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 116.0, 123.0, 116.0, 116.0, 115.0, 115.0, 113.0, 126.0, 121.0], "value": 118.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 170.0, 179.0, 169.0, 167.0, 166.0, 175.0, 172.0, 180.0, 172.0], "value": 172.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 64.0, 65.0, 71.0, 66.0, 64.0, 64.0, 65.0, 66.0], "value": 65.9, "unit": "score"}]}]} 07:24:14 INFO - Return code: 0 07:24:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:24:14 INFO - # TBPL SUCCESS # 07:24:14 INFO - Running post-action listener: _package_coverage_data 07:24:14 INFO - Running post-action listener: _resource_record_post_action 07:24:14 INFO - [mozharness: 2017-09-21 14:24:14.468061Z] Finished run-tests step (success) 07:24:14 INFO - Running post-run listener: _resource_record_post_run 07:24:14 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 53248; Write bytes: 331456512; Read time: 396; Write time: 209900 07:24:14 INFO - TinderboxPrint: CPU usage
13.3% 07:24:14 INFO - TinderboxPrint: I/O read bytes / time
53,248 / 396 07:24:14 INFO - TinderboxPrint: I/O write bytes / time
331,456,512 / 209,900 07:24:14 INFO - TinderboxPrint: CPU idle
8,258.2 (86.7%) 07:24:14 INFO - TinderboxPrint: CPU user
1,202.7 (12.6%) 07:24:14 INFO - TinderboxPrint: Swap in / out
0 / 0 07:24:14 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 9916416; Read time: 0; Write time: 596 07:24:14 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 07:24:14 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 49152; Write bytes: 321142784; Read time: 388; Write time: 209280 07:24:15 INFO - Running post-run listener: _upload_blobber_files 07:24:15 INFO - Blob upload gear active. 07:24:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:24:15 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:24:15 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'] 07:24:15 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 07:24:15 INFO - (blobuploader) - INFO - Open directory for files ... 07:24:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:24:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:24:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:24:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:24:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:24:16 INFO - (blobuploader) - INFO - Done attempting. 07:24:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:24:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:24:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:24:17 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:24:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:24:17 INFO - (blobuploader) - INFO - Done attempting. 07:24:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:24:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:24:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:24:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:24:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:24:24 INFO - (blobuploader) - INFO - Done attempting. 07:24:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:24:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:24:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:24:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:24:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:24:25 INFO - (blobuploader) - INFO - Done attempting. 07:24:25 INFO - (blobuploader) - INFO - Iteration through files over. 07:24:25 INFO - Return code: 0 07:24:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:24:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:24:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee12d73cbf3f8a5b09aa3c95fe050bc61863bdc0061f8ad45c0f7694e1f2d83af3496e19d64d584c8456d2c7e40aed8c4fd1277d861cca11e0f58c680bf73268", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32b492e722ed173509554f9fa44c5a0f15aef93222b4676aee8d6fd437b314e02f42e087333dae7a353d9b3c4d6dad1060351fe5bc865bbe11983854baceb99b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f654b1dc578e2a39345f95bd7b25adb01931788ab1e042643f761a9d91e1d4ad3c4a8e692d2c62d38b3c0553c16601af9e076761ccd4b77e15ac94c40b695aa", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb8bc88d97151eb15047c26e47657c782ec8dd852c37c125c1c2f5acdd2237b82f7579a08326e2563bf8a874234eb82363e5d3643dd2c50fddc9bac49126b7d8"} 07:24:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:24:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:24:25 INFO - Contents: 07:24:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee12d73cbf3f8a5b09aa3c95fe050bc61863bdc0061f8ad45c0f7694e1f2d83af3496e19d64d584c8456d2c7e40aed8c4fd1277d861cca11e0f58c680bf73268", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32b492e722ed173509554f9fa44c5a0f15aef93222b4676aee8d6fd437b314e02f42e087333dae7a353d9b3c4d6dad1060351fe5bc865bbe11983854baceb99b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f654b1dc578e2a39345f95bd7b25adb01931788ab1e042643f761a9d91e1d4ad3c4a8e692d2c62d38b3c0553c16601af9e076761ccd4b77e15ac94c40b695aa", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb8bc88d97151eb15047c26e47657c782ec8dd852c37c125c1c2f5acdd2237b82f7579a08326e2563bf8a874234eb82363e5d3643dd2c50fddc9bac49126b7d8"} 07:24:25 INFO - Running post-run listener: copy_logs_to_upload_dir 07:24:25 INFO - Copying logs to upload dir... 07:24:25 INFO - mkdir: /builds/slave/test/build/upload/logs 07:24:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.503037 ========= master_lag: 0.16 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-09-21 07:24:25.320634) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-21 07:24:25.332124) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1506002182.263489-733130944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee12d73cbf3f8a5b09aa3c95fe050bc61863bdc0061f8ad45c0f7694e1f2d83af3496e19d64d584c8456d2c7e40aed8c4fd1277d861cca11e0f58c680bf73268", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32b492e722ed173509554f9fa44c5a0f15aef93222b4676aee8d6fd437b314e02f42e087333dae7a353d9b3c4d6dad1060351fe5bc865bbe11983854baceb99b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f654b1dc578e2a39345f95bd7b25adb01931788ab1e042643f761a9d91e1d4ad3c4a8e692d2c62d38b3c0553c16601af9e076761ccd4b77e15ac94c40b695aa", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb8bc88d97151eb15047c26e47657c782ec8dd852c37c125c1c2f5acdd2237b82f7579a08326e2563bf8a874234eb82363e5d3643dd2c50fddc9bac49126b7d8"} build_url:https://queue.taskcluster.net/v1/task/OR_WzdNeS6ee0KU9V4iMiw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.009845 build_url: 'https://queue.taskcluster.net/v1/task/OR_WzdNeS6ee0KU9V4iMiw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee12d73cbf3f8a5b09aa3c95fe050bc61863bdc0061f8ad45c0f7694e1f2d83af3496e19d64d584c8456d2c7e40aed8c4fd1277d861cca11e0f58c680bf73268", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32b492e722ed173509554f9fa44c5a0f15aef93222b4676aee8d6fd437b314e02f42e087333dae7a353d9b3c4d6dad1060351fe5bc865bbe11983854baceb99b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f654b1dc578e2a39345f95bd7b25adb01931788ab1e042643f761a9d91e1d4ad3c4a8e692d2c62d38b3c0553c16601af9e076761ccd4b77e15ac94c40b695aa", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb8bc88d97151eb15047c26e47657c782ec8dd852c37c125c1c2f5acdd2237b82f7579a08326e2563bf8a874234eb82363e5d3643dd2c50fddc9bac49126b7d8"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-21 07:24:25.378769) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 07:24:25.379199) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1506002182.263489-733130944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004440 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-21 07:24:25.429624) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-21 07:24:25.429940) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-21 07:24:25.430261) ========= ========= Total master_lag: 0.31 =========