builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-084 starttime: 1504212742.91 results: success (0) revision: 13d241d08912be31884f9d0d0e805b25343d6c0a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-31 13:52:22.911060) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-31 13:52:22.911604) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-31 13:52:22.911928) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-31 13:52:23.012865) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 13:52:23.013135) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ea65d483da93c827905c2090000001f5-1504212552.181106-1619623144 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-31 13:52:23-- 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% 46.6M=0s 2017-08-31 13:52:23 (46.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.109361 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 13:52:23.156166) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 13:52:23.156471) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ea65d483da93c827905c2090000001f5-1504212552.181106-1619623144 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014980 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 13:52:23.215622) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 13:52:23.216037) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 13d241d08912be31884f9d0d0e805b25343d6c0a --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 13d241d08912be31884f9d0d0e805b25343d6c0a --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ea65d483da93c827905c2090000001f5-1504212552.181106-1619623144 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-31 13:52:23,291 truncating revision to first 12 chars 2017-08-31 13:52:23,291 Setting DEBUG logging. 2017-08-31 13:52:23,291 attempt 1/10 2017-08-31 13:52:23,291 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/13d241d08912?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-31 13:52:23,612 unpacking tar archive at: mozilla-central-13d241d08912/testing/mozharness/ program finished with exit code 0 elapsedTime=0.671993 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 13:52:23.909987) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-31 13:52:23.910307) ========= script_repo_revision: 13d241d08912be31884f9d0d0e805b25343d6c0a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-31 13:52:23.910726) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-31 13:52:23.910998) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-31 13:52:23.921889) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-31 13:52:23.922162) ========= /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=ea65d483da93c827905c2090000001f5-1504212552.181106-1619623144 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:52:24 INFO - MultiFileLogger online at 20170831 13:52:24 in /builds/slave/test 13:52:24 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 13:52:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:52:24 INFO - {'append_to_log': False, 13:52:24 INFO - 'base_work_dir': '/builds/slave/test', 13:52:24 INFO - 'blob_upload_branch': 'Firefox', 13:52:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:52:24 INFO - 'branch': 'Firefox', 13:52:24 INFO - 'buildbot_json_path': 'buildprops.json', 13:52:24 INFO - 'code_coverage': False, 13:52:24 INFO - 'config_files': ('talos/linux_config.py',), 13:52:24 INFO - 'default_actions': ('clobber', 13:52:24 INFO - 'read-buildbot-config', 13:52:24 INFO - 'download-and-extract', 13:52:24 INFO - 'populate-webroot', 13:52:24 INFO - 'create-virtualenv', 13:52:24 INFO - 'install', 13:52:24 INFO - 'setup-mitmproxy', 13:52:24 INFO - 'run-tests'), 13:52:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:52:24 INFO - 'disable_ccov_upload': False, 13:52:24 INFO - 'disable_stylo': False, 13:52:24 INFO - 'download_minidump_stackwalk': True, 13:52:24 INFO - 'download_symbols': 'ondemand', 13:52:24 INFO - 'enable_stylo': False, 13:52:24 INFO - 'enable_webrender': False, 13:52:24 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 13:52:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:52:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:52:24 INFO - 'gecko_profile': False, 13:52:24 INFO - 'gecko_profile_interval': 0, 13:52:24 INFO - 'installer_path': 'installer.exe', 13:52:24 INFO - 'log_level': 'info', 13:52:24 INFO - 'log_name': 'talos', 13:52:24 INFO - 'log_to_console': True, 13:52:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:52:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:52:24 INFO - 'opt_config_files': (), 13:52:24 INFO - 'pip_index': False, 13:52:24 INFO - 'suite': 'dromaeojs-e10s', 13:52:24 INFO - 'system_bits': '32', 13:52:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:52:24 INFO - 'title': 'talos-linux64-ix-084', 13:52:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:52:24 INFO - 'use_talos_json': True, 13:52:24 INFO - 'verify': 'False', 13:52:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:52:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:52:24 INFO - 'work_dir': 'build'} 13:52:24 INFO - [mozharness: 2017-08-31 20:52:24.134463Z] Running clobber step. 13:52:24 INFO - Running pre-action listener: _resource_record_pre_action 13:52:24 INFO - Running main action method: clobber 13:52:24 INFO - rmtree: /builds/slave/test/build 13:52:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:52:25 INFO - Running post-action listener: _resource_record_post_action 13:52:25 INFO - [mozharness: 2017-08-31 20:52:25.665652Z] Finished clobber step (success) 13:52:25 INFO - [mozharness: 2017-08-31 20:52:25.665749Z] Running read-buildbot-config step. 13:52:25 INFO - Running pre-action listener: _resource_record_pre_action 13:52:25 INFO - Running main action method: read_buildbot_config 13:52:25 INFO - Using buildbot properties: 13:52:25 INFO - { 13:52:25 INFO - "project": "", 13:52:25 INFO - "product": "firefox", 13:52:25 INFO - "who": "kwierso@gmail.com", 13:52:25 INFO - "installer_path": "public/build/target.tar.bz2", 13:52:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 13:52:25 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 13:52:25 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 13:52:25 INFO - "stage_platform": "linux64-qr", 13:52:25 INFO - "basedir": "/builds/slave/test", 13:52:25 INFO - "buildnumber": 23, 13:52:25 INFO - "platform": "ubuntu64_hw_qr", 13:52:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:52:25 INFO - "slavebuilddir": "test", 13:52:25 INFO - "taskId": "SDCPs_ulTTawacb3lcwX7Q", 13:52:25 INFO - "branch": "mozilla-central", 13:52:25 INFO - "script_repo_revision": "production", 13:52:25 INFO - "revision": "13d241d08912be31884f9d0d0e805b25343d6c0a", 13:52:25 INFO - "slavename": "talos-linux64-ix-084", 13:52:25 INFO - "repo_path": "mozilla-central" 13:52:25 INFO - } 13:52:25 INFO - Finding installer, test and symbols from parent task. 13:52:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SDCPs_ulTTawacb3lcwX7Q'}, attempt #1 13:52:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SDCPs_ulTTawacb3lcwX7Q'}, attempt #1 13:52:26 INFO - Task dependencies: ZFWS62EnTCq2ZhmByr1xKg 13:52:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg'}, attempt #1 13:52:27 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.tar.bz2 13:52:27 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.test_packages.json 13:52:27 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.crashreporter-symbols.zip 13:52:27 INFO - Running post-action listener: _resource_record_post_action 13:52:27 INFO - [mozharness: 2017-08-31 20:52:27.025938Z] Finished read-buildbot-config step (success) 13:52:27 INFO - [mozharness: 2017-08-31 20:52:27.026155Z] Running download-and-extract step. 13:52:27 INFO - Running pre-action listener: _resource_record_pre_action 13:52:27 INFO - Running main action method: download_and_extract 13:52:27 INFO - mkdir: /builds/slave/test/build/tests 13:52:27 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')]} 13:52:27 INFO - trying https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.test_packages.json 13:52:27 INFO - Downloading https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 13:52:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 13:52:27 INFO - Downloaded 989 bytes. 13:52:27 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 13:52:27 INFO - Using the following test package requirements: 13:52:27 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 13:52:27 INFO - u'common': [u'target.common.tests.zip'], 13:52:27 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 13:52:27 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 13:52:27 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 13:52:27 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 13:52:27 INFO - u'mozbase': [u'target.common.tests.zip'], 13:52:27 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 13:52:27 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 13:52:27 INFO - u'web-platform': [u'target.common.tests.zip', 13:52:27 INFO - u'target.web-platform.tests.tar.gz'], 13:52:27 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 13:52:27 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 13:52:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.common.tests.zip 13:52:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:52:27 INFO - Fetch https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.common.tests.zip into memory 13:52:28 INFO - Content-Length response header: 54932967 13:52:28 INFO - Bytes received: 54932967 13:52:39 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 13:52:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.common.tests.zip 13:52:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:52:39 INFO - Fetch https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.common.tests.zip into memory 13:52:40 INFO - Content-Length response header: 54932967 13:52:40 INFO - Bytes received: 54932967 13:52:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.talos.tests.zip 13:52:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 13:52:52 INFO - Fetch https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.talos.tests.zip into memory 13:52:53 INFO - Content-Length response header: 14496650 13:52:53 INFO - Bytes received: 14496650 13:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:52:53 INFO - trying https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.tar.bz2 13:52:53 INFO - Downloading https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 13:52:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 13:52:54 INFO - Downloaded 62641049 bytes. 13:52:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.tar.bz2 13:52:54 INFO - mkdir: /builds/slave/test/properties 13:52:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:52:54 INFO - Writing to file /builds/slave/test/properties/build_url 13:52:54 INFO - Contents: 13:52:54 INFO - build_url:https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.tar.bz2 13:52:54 INFO - Running post-action listener: _resource_record_post_action 13:52:54 INFO - Running post-action listener: find_tests_for_verification 13:52:54 INFO - Running post-action listener: set_extra_try_arguments 13:52:54 INFO - [mozharness: 2017-08-31 20:52:54.928758Z] Finished download-and-extract step (success) 13:52:54 INFO - [mozharness: 2017-08-31 20:52:54.928854Z] Running populate-webroot step. 13:52:54 INFO - Running pre-action listener: _resource_record_pre_action 13:52:54 INFO - Running main action method: populate_webroot 13:52:54 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:52:54 INFO - 'chromez-stylo-e10s': {'talos_options': ['--enable-stylo'], 13:52:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:52:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:52:54 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--enable-stylo'], 13:52:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:52:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:52:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:52:54 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 13:52:54 INFO - 'talos_options': ['--enable-stylo'], 13:52:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:52:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:52:54 INFO - 'tests': ['damp', 'tps']}, 13:52:54 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 13:52:54 INFO - 'talos_options': ['--enable-stylo'], 13:52:54 INFO - 'tests': ['damp', 'tps']}, 13:52:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:52:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 13:52:54 INFO - 'g4-stylo-e10s': {'talos_options': ['--enable-stylo'], 13:52:54 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 13:52:54 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 13:52:54 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 13:52:54 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 13:52:54 INFO - 'talos_options': ['--enable-stylo'], 13:52:54 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 13:52:54 INFO - 'other-e10s': {'tests': ['a11yr', 13:52:54 INFO - 'ts_paint', 13:52:54 INFO - 'tpaint', 13:52:54 INFO - 'sessionrestore', 13:52:54 INFO - 'sessionrestore_many_windows', 13:52:54 INFO - 'sessionrestore_no_auto_restore', 13:52:54 INFO - 'tabpaint']}, 13:52:54 INFO - 'other-stylo-e10s': {'talos_options': ['--enable-stylo'], 13:52:54 INFO - 'tests': ['a11yr', 13:52:54 INFO - 'ts_paint', 13:52:54 INFO - 'tpaint', 13:52:54 INFO - 'sessionrestore', 13:52:54 INFO - 'sessionrestore_many_windows', 13:52:54 INFO - 'sessionrestore_no_auto_restore', 13:52:54 INFO - 'tabpaint']}, 13:52:54 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 13:52:54 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 13:52:54 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--enable-stylo'], 13:52:54 INFO - 'tests': ['bloom_basic_singleton']}, 13:52:54 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--enable-stylo'], 13:52:54 INFO - 'tests': ['bloom_basic']}, 13:52:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:52:54 INFO - 'tsvgr_opacity', 13:52:54 INFO - 'tart', 13:52:54 INFO - 'tscrollx', 13:52:54 INFO - 'tsvg_static']}, 13:52:54 INFO - 'svgr-stylo-e10s': {'talos_options': ['--enable-stylo'], 13:52:54 INFO - 'tests': ['tsvgx', 13:52:54 INFO - 'tsvgr_opacity', 13:52:54 INFO - 'tart', 13:52:54 INFO - 'tscrollx', 13:52:54 INFO - 'tsvg_static']}, 13:52:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:52:54 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 13:52:54 INFO - 'talos_options': ['--enable-stylo'], 13:52:54 INFO - 'tests': ['tp5o']}, 13:52:54 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:52:54 INFO - 'talos_options': ['--mitmproxy', 13:52:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:52:54 INFO - '--firstNonBlankPaint'], 13:52:54 INFO - 'tests': ['tp6_google', 13:52:54 INFO - 'tp6_youtube', 13:52:54 INFO - 'tp6_amazon', 13:52:54 INFO - 'tp6_facebook']}, 13:52:54 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:52:54 INFO - 'talos_options': ['--enable-stylo', 13:52:54 INFO - '--mitmproxy', 13:52:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:52:54 INFO - '--firstNonBlankPaint'], 13:52:54 INFO - 'tests': ['tp6_google', 13:52:54 INFO - 'tp6_youtube', 13:52:54 INFO - 'tp6_amazon', 13:52:54 INFO - 'tp6_facebook']}, 13:52:54 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:52:54 INFO - 'talos_options': ['--enable-stylo', 13:52:54 INFO - '--stylo-threads=1', 13:52:54 INFO - '--mitmproxy', 13:52:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:52:54 INFO - '--firstNonBlankPaint'], 13:52:54 INFO - 'tests': ['tp6_google', 13:52:54 INFO - 'tp6_youtube', 13:52:54 INFO - 'tp6_amazon', 13:52:54 INFO - 'tp6_facebook']}, 13:52:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:52:54 INFO - 'talos_options': ['--xperf_path', 13:52:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:52:54 INFO - 'tests': ['tp5n']}, 13:52:54 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 13:52:54 INFO - 'talos_options': ['--enable-stylo', 13:52:54 INFO - '--xperf_path', 13:52:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:52:54 INFO - 'tests': ['tp5n']}}} 13:52:54 INFO - Running post-action listener: _resource_record_post_action 13:52:54 INFO - [mozharness: 2017-08-31 20:52:54.943248Z] Finished populate-webroot step (success) 13:52:54 INFO - [mozharness: 2017-08-31 20:52:54.943337Z] Running create-virtualenv step. 13:52:54 INFO - Running pre-action listener: _resource_record_pre_action 13:52:54 INFO - Running main action method: create_virtualenv 13:52:54 INFO - Creating virtualenv /builds/slave/test/build/venv 13:52:54 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:52:54 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 13:52:54 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 13:52:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:52:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:52:55 INFO - Installing distribute.............................................................................................................................................................................................done. 13:52:55 INFO - Installing pip...............done. 13:52:55 INFO - Return code: 0 13:52:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:52:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:52:55 INFO - Reading from file tmpfile_stdout 13:52:55 INFO - Output received: 13:52:55 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 13:52:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:52:55 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')]} 13:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:55 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')]} 13:52:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:55 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 0x238b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2554a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fb090>, '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 0x26fbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f5f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1504212552.181106-1619623144', '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 13:52:55 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 13:52:55 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 13:52:55 INFO - Using env: {'DISPLAY': ':0', 13:52:55 INFO - 'HOME': '/home/cltbld', 13:52:55 INFO - 'LANG': 'en_US.UTF-8', 13:52:55 INFO - 'LANGUAGE': 'en_US:en', 13:52:55 INFO - 'LOGNAME': 'cltbld', 13:52:55 INFO - 'MAIL': '/var/mail/cltbld', 13:52:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:55 INFO - 'MOZ_NO_REMOTE': '1', 13:52:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:55 INFO - 'NO_EM_RESTART': '1', 13:52:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:55 INFO - 'PWD': '/builds/slave/test', 13:52:55 INFO - 'SHELL': '/bin/bash', 13:52:55 INFO - 'SHLVL': '1', 13:52:55 INFO - 'TERM': 'linux', 13:52:55 INFO - 'TMOUT': '86400', 13:52:55 INFO - 'USER': 'cltbld', 13:52:55 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1504212552.181106-1619623144', 13:52:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:55 INFO - '_': '/tools/buildbot/bin/python'} 13:52:57 INFO - Ignoring indexes: http://pypi.python.org/simple/ 13:52:57 INFO - Downloading/unpacking pip>=1.5 13:52:57 INFO - Running setup.py egg_info for package pip 13:52:57 INFO - warning: no files found matching 'pip/cacert.pem' 13:52:57 INFO - warning: no files found matching '*.html' under directory 'docs' 13:52:57 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 13:52:57 INFO - no previously-included directories found matching 'docs/_build/_sources' 13:52:57 INFO - Installing collected packages: pip 13:52:57 INFO - Found existing installation: pip 1.1 13:52:57 INFO - Uninstalling pip: 13:52:57 INFO - Successfully uninstalled pip 13:52:57 INFO - Running setup.py install for pip 13:52:57 INFO - warning: no files found matching 'pip/cacert.pem' 13:52:57 INFO - warning: no files found matching '*.html' under directory 'docs' 13:52:57 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 13:52:57 INFO - no previously-included directories found matching 'docs/_build/_sources' 13:52:57 INFO - Installing pip script to /builds/slave/test/build/venv/bin 13:52:57 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 13:52:57 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 13:52:57 INFO - Successfully installed pip 13:52:57 INFO - Cleaning up... 13:52:57 INFO - Return code: 0 13:52:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:52:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:52:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:57 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 0x238b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2554a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fb090>, '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 0x26fbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f5f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1504212552.181106-1619623144', '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 13:52:57 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 13:52:57 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 13:52:57 INFO - Using env: {'DISPLAY': ':0', 13:52:57 INFO - 'HOME': '/home/cltbld', 13:52:57 INFO - 'LANG': 'en_US.UTF-8', 13:52:57 INFO - 'LANGUAGE': 'en_US:en', 13:52:57 INFO - 'LOGNAME': 'cltbld', 13:52:57 INFO - 'MAIL': '/var/mail/cltbld', 13:52:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:57 INFO - 'MOZ_NO_REMOTE': '1', 13:52:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:57 INFO - 'NO_EM_RESTART': '1', 13:52:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:57 INFO - 'PWD': '/builds/slave/test', 13:52:57 INFO - 'SHELL': '/bin/bash', 13:52:57 INFO - 'SHLVL': '1', 13:52:57 INFO - 'TERM': 'linux', 13:52:57 INFO - 'TMOUT': '86400', 13:52:57 INFO - 'USER': 'cltbld', 13:52:57 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1504212552.181106-1619623144', 13:52:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:57 INFO - '_': '/tools/buildbot/bin/python'} 13:52:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:57 INFO - Downloading/unpacking psutil>=3.1.1 13:52:57 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 13:52:57 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 13:52:57 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 13:52:57 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 13:52:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:52:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:52:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:52:58 INFO - Installing collected packages: psutil 13:52:58 INFO - Running setup.py install for psutil 13:52:58 INFO - building 'psutil._psutil_linux' extension 13:52:58 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 13:52:58 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 13:52:58 INFO - building 'psutil._psutil_posix' extension 13:52:58 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 13:52:58 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 13:52:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:52:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:52:59 INFO - Successfully installed psutil 13:52:59 INFO - Cleaning up... 13:52:59 INFO - Return code: 0 13:52:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:52:59 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')]} 13:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:59 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')]} 13:52:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:59 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 0x238b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2554a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fb090>, '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 0x26fbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f5f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1504212552.181106-1619623144', '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 13:52:59 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 13:52:59 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 13:52:59 INFO - Using env: {'DISPLAY': ':0', 13:52:59 INFO - 'HOME': '/home/cltbld', 13:52:59 INFO - 'LANG': 'en_US.UTF-8', 13:52:59 INFO - 'LANGUAGE': 'en_US:en', 13:52:59 INFO - 'LOGNAME': 'cltbld', 13:52:59 INFO - 'MAIL': '/var/mail/cltbld', 13:52:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:59 INFO - 'MOZ_NO_REMOTE': '1', 13:52:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:59 INFO - 'NO_EM_RESTART': '1', 13:52:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:59 INFO - 'PWD': '/builds/slave/test', 13:52:59 INFO - 'SHELL': '/bin/bash', 13:52:59 INFO - 'SHLVL': '1', 13:52:59 INFO - 'TERM': 'linux', 13:52:59 INFO - 'TMOUT': '86400', 13:52:59 INFO - 'USER': 'cltbld', 13:52:59 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1504212552.181106-1619623144', 13:52:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:59 INFO - '_': '/tools/buildbot/bin/python'} 13:52:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:52:59 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 13:52:59 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 13:52:59 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 13:52:59 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 13:53:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:53:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:53:00 INFO - Installing collected packages: mozsystemmonitor 13:53:00 INFO - Running setup.py install for mozsystemmonitor 13:53:00 INFO - Successfully installed mozsystemmonitor 13:53:00 INFO - Cleaning up... 13:53:00 INFO - Return code: 0 13:53:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:53: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')]} 13:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:53: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')]} 13:53:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:53: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', '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 0x238b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2554a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fb090>, '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 0x26fbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f5f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1504212552.181106-1619623144', '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 13:53: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:53: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 jsonschema==2.5.1 13:53:00 INFO - Using env: {'DISPLAY': ':0', 13:53:00 INFO - 'HOME': '/home/cltbld', 13:53:00 INFO - 'LANG': 'en_US.UTF-8', 13:53:00 INFO - 'LANGUAGE': 'en_US:en', 13:53:00 INFO - 'LOGNAME': 'cltbld', 13:53:00 INFO - 'MAIL': '/var/mail/cltbld', 13:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:53:00 INFO - 'MOZ_NO_REMOTE': '1', 13:53:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:53:00 INFO - 'NO_EM_RESTART': '1', 13:53:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:53:00 INFO - 'PWD': '/builds/slave/test', 13:53:00 INFO - 'SHELL': '/bin/bash', 13:53:00 INFO - 'SHLVL': '1', 13:53:00 INFO - 'TERM': 'linux', 13:53:00 INFO - 'TMOUT': '86400', 13:53:00 INFO - 'USER': 'cltbld', 13:53:00 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1504212552.181106-1619623144', 13:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:53:00 INFO - '_': '/tools/buildbot/bin/python'} 13:53:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:53:00 INFO - Downloading/unpacking jsonschema==2.5.1 13:53: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 13:53: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 13:53: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 13:53: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 13:53:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:53:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:53:01 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 13:53:01 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 13:53:01 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 13:53:01 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 13:53:02 INFO - Downloading functools32-3.2.3-2.tar.gz 13:53:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:53:02 INFO - warning: no files found matching '*.txt' 13:53:02 INFO - no previously-included directories found matching 'build' 13:53:02 INFO - no previously-included directories found matching 'dist' 13:53:02 INFO - no previously-included directories found matching '.git*' 13:53:02 INFO - Installing collected packages: jsonschema, functools32 13:53:02 INFO - Running setup.py install for functools32 13:53:02 INFO - warning: no files found matching '*.txt' 13:53:02 INFO - no previously-included directories found matching 'build' 13:53:02 INFO - no previously-included directories found matching 'dist' 13:53:02 INFO - no previously-included directories found matching '.git*' 13:53:02 INFO - Successfully installed jsonschema functools32 13:53:02 INFO - Cleaning up... 13:53:02 INFO - Return code: 0 13:53:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:53:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:53:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x238b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2554a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fb090>, '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 0x26fbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f5f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1504212552.181106-1619623144', '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 13:53:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:53:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:53:02 INFO - Using env: {'DISPLAY': ':0', 13:53:02 INFO - 'HOME': '/home/cltbld', 13:53:02 INFO - 'LANG': 'en_US.UTF-8', 13:53:02 INFO - 'LANGUAGE': 'en_US:en', 13:53:02 INFO - 'LOGNAME': 'cltbld', 13:53:02 INFO - 'MAIL': '/var/mail/cltbld', 13:53:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:53:02 INFO - 'MOZ_NO_REMOTE': '1', 13:53:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:53:02 INFO - 'NO_EM_RESTART': '1', 13:53:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:53:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:53:02 INFO - 'PWD': '/builds/slave/test', 13:53:02 INFO - 'SHELL': '/bin/bash', 13:53:02 INFO - 'SHLVL': '1', 13:53:02 INFO - 'TERM': 'linux', 13:53:02 INFO - 'TMOUT': '86400', 13:53:02 INFO - 'USER': 'cltbld', 13:53:02 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1504212552.181106-1619623144', 13:53:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:53:02 INFO - '_': '/tools/buildbot/bin/python'} 13:53:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:53:02 INFO - Cleaning up... 13:53:02 INFO - Return code: 0 13:53:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:53:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:53:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x238b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2554a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fb090>, '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 0x26fbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f5f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1504212552.181106-1619623144', '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 13:53:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:53:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:53:02 INFO - Using env: {'DISPLAY': ':0', 13:53:02 INFO - 'HOME': '/home/cltbld', 13:53:02 INFO - 'LANG': 'en_US.UTF-8', 13:53:02 INFO - 'LANGUAGE': 'en_US:en', 13:53:02 INFO - 'LOGNAME': 'cltbld', 13:53:02 INFO - 'MAIL': '/var/mail/cltbld', 13:53:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:53:02 INFO - 'MOZ_NO_REMOTE': '1', 13:53:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:53:02 INFO - 'NO_EM_RESTART': '1', 13:53:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:53:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:53:02 INFO - 'PWD': '/builds/slave/test', 13:53:02 INFO - 'SHELL': '/bin/bash', 13:53:02 INFO - 'SHLVL': '1', 13:53:02 INFO - 'TERM': 'linux', 13:53:02 INFO - 'TMOUT': '86400', 13:53:02 INFO - 'USER': 'cltbld', 13:53:02 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1504212552.181106-1619623144', 13:53:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:53:02 INFO - '_': '/tools/buildbot/bin/python'} 13:53:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:53:02 INFO - Downloading/unpacking blobuploader==1.2.4 13:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:53:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:53:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:53:03 INFO - Downloading blobuploader-1.2.4.tar.gz 13:53:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:53:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:53: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 13:53: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 13:53: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 13:53: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 13:53:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:53:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:53:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:53:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:53:04 INFO - Downloading docopt-0.6.1.tar.gz 13:53:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:53:04 INFO - Installing collected packages: blobuploader, requests, docopt 13:53:04 INFO - Running setup.py install for blobuploader 13:53:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:53:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:53:04 INFO - Running setup.py install for requests 13:53:04 INFO - Running setup.py install for docopt 13:53:04 INFO - Successfully installed blobuploader requests docopt 13:53:04 INFO - Cleaning up... 13:53:04 INFO - Return code: 0 13:53:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:53:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:53:04 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 0x238b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2554a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fb090>, '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 0x26fbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f5f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1504212552.181106-1619623144', '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 13:53:04 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 13:53:04 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 13:53:04 INFO - Using env: {'DISPLAY': ':0', 13:53:04 INFO - 'HOME': '/home/cltbld', 13:53:04 INFO - 'LANG': 'en_US.UTF-8', 13:53:04 INFO - 'LANGUAGE': 'en_US:en', 13:53:04 INFO - 'LOGNAME': 'cltbld', 13:53:04 INFO - 'MAIL': '/var/mail/cltbld', 13:53:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:53:04 INFO - 'MOZ_NO_REMOTE': '1', 13:53:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:53:04 INFO - 'NO_EM_RESTART': '1', 13:53:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:53:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:53:04 INFO - 'PWD': '/builds/slave/test', 13:53:04 INFO - 'SHELL': '/bin/bash', 13:53:04 INFO - 'SHLVL': '1', 13:53:04 INFO - 'TERM': 'linux', 13:53:04 INFO - 'TMOUT': '86400', 13:53:04 INFO - 'USER': 'cltbld', 13:53:04 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1504212552.181106-1619623144', 13:53:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:53:04 INFO - '_': '/tools/buildbot/bin/python'} 13:53:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:53:05 INFO - Running setup.py (path:/tmp/pip-0Ek4WA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:53:05 INFO - Running setup.py (path:/tmp/pip-Pl2lGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:53:05 INFO - Running setup.py (path:/tmp/pip-CoMbQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:53:05 INFO - Running setup.py (path:/tmp/pip-ChPj52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:53:05 INFO - Running setup.py (path:/tmp/pip-tTweqh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:53:05 INFO - Running setup.py (path:/tmp/pip-WayKYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:53:05 INFO - Running setup.py (path:/tmp/pip-jvEhWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:53:05 INFO - Running setup.py (path:/tmp/pip-9qbfY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:53:05 INFO - Running setup.py (path:/tmp/pip-L5GMI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:53:05 INFO - Running setup.py (path:/tmp/pip-dpYkk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:53:05 INFO - Running setup.py (path:/tmp/pip-_FxRUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:53:05 INFO - Running setup.py (path:/tmp/pip-uuUWRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:53:06 INFO - Running setup.py (path:/tmp/pip-Qgs1Af-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:53:06 INFO - Running setup.py (path:/tmp/pip-PSEt7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:53:06 INFO - Running setup.py (path:/tmp/pip-m2B5on-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:53:06 INFO - Running setup.py (path:/tmp/pip-Ex_PTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:53:06 INFO - Running setup.py (path:/tmp/pip-UWDQkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:53:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:53:06 INFO - Running setup.py install for manifestparser 13:53:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:53:06 INFO - Running setup.py install for mozcrash 13:53:06 INFO - Running setup.py install for mozdebug 13:53:06 INFO - Running setup.py install for mozdevice 13:53:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:53:06 INFO - Running setup.py install for mozfile 13:53:06 INFO - Running setup.py install for mozhttpd 13:53:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:53:06 INFO - Running setup.py install for mozinfo 13:53:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:53:07 INFO - Running setup.py install for mozInstall 13:53:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:53:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:53:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:53:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:53:07 INFO - Running setup.py install for mozleak 13:53:07 INFO - Running setup.py install for mozlog 13:53:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:53:07 INFO - Running setup.py install for moznetwork 13:53:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:53:07 INFO - Running setup.py install for mozprocess 13:53:07 INFO - Running setup.py install for mozprofile 13:53:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:53:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:53:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:53:07 INFO - Running setup.py install for mozrunner 13:53:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:53:07 INFO - Running setup.py install for mozscreenshot 13:53:07 INFO - Running setup.py install for moztest 13:53:08 INFO - Running setup.py install for mozversion 13:53:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:53:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:53:08 INFO - Cleaning up... 13:53:08 INFO - Return code: 0 13:53:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:53:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:53:08 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 0x238b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2554a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fb090>, '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 0x26fbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f5f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1504212552.181106-1619623144', '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 13:53:08 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 13:53:08 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 13:53:08 INFO - Using env: {'DISPLAY': ':0', 13:53:08 INFO - 'HOME': '/home/cltbld', 13:53:08 INFO - 'LANG': 'en_US.UTF-8', 13:53:08 INFO - 'LANGUAGE': 'en_US:en', 13:53:08 INFO - 'LOGNAME': 'cltbld', 13:53:08 INFO - 'MAIL': '/var/mail/cltbld', 13:53:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:53:08 INFO - 'MOZ_NO_REMOTE': '1', 13:53:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:53:08 INFO - 'NO_EM_RESTART': '1', 13:53:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:53:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:53:08 INFO - 'PWD': '/builds/slave/test', 13:53:08 INFO - 'SHELL': '/bin/bash', 13:53:08 INFO - 'SHLVL': '1', 13:53:08 INFO - 'TERM': 'linux', 13:53:08 INFO - 'TMOUT': '86400', 13:53:08 INFO - 'USER': 'cltbld', 13:53:08 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1504212552.181106-1619623144', 13:53:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:53:08 INFO - '_': '/tools/buildbot/bin/python'} 13:53:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:53:08 INFO - Running setup.py (path:/tmp/pip-puyanG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:53:08 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)) 13:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:53:08 INFO - Running setup.py (path:/tmp/pip-8NT3l8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:53:08 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)) 13:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:53:08 INFO - Running setup.py (path:/tmp/pip-Rb4YWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:53:08 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)) 13:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:53:08 INFO - Running setup.py (path:/tmp/pip-Mqm9C3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:53:08 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)) 13:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:53:08 INFO - Running setup.py (path:/tmp/pip-cp6hfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:53:08 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)) 13:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:53:08 INFO - Running setup.py (path:/tmp/pip-JdA1Gj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:53:08 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)) 13:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:53:08 INFO - Running setup.py (path:/tmp/pip-NMXiMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:53:08 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)) 13:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:53:08 INFO - Running setup.py (path:/tmp/pip-Q0t9k3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:53:08 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)) 13:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:53:08 INFO - Running setup.py (path:/tmp/pip-nobRZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:53:08 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)) 13:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:53:08 INFO - Running setup.py (path:/tmp/pip-KP5uRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:53:09 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)) 13:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:53:09 INFO - Running setup.py (path:/tmp/pip-lwgCO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:53:09 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)) 13:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:53:09 INFO - Running setup.py (path:/tmp/pip-cPoFOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:53:09 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)) 13:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:53:09 INFO - Running setup.py (path:/tmp/pip-iobrEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:53:09 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)) 13:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:53:09 INFO - Running setup.py (path:/tmp/pip-YEsiUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:53:09 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)) 13:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:53:09 INFO - Running setup.py (path:/tmp/pip-ql63CY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:53:09 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)) 13:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:53:09 INFO - Running setup.py (path:/tmp/pip-NjhWQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:53:09 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)) 13:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:53:09 INFO - Running setup.py (path:/tmp/pip-LyQVpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:53:09 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)) 13:53:09 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)) 13:53:09 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)) 13:53:09 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)) 13:53:09 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)) 13:53:09 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)) 13:53:09 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)) 13:53:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:53: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 13:53: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 13:53: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 13:53: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 13:53:10 INFO - Downloading blessings-1.6.tar.gz 13:53:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:53:10 INFO - Installing collected packages: blessings 13:53:10 INFO - Running setup.py install for blessings 13:53:10 INFO - Successfully installed blessings 13:53:10 INFO - Cleaning up... 13:53:10 INFO - Return code: 0 13:53:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:53:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:53:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:53:11 INFO - Reading from file tmpfile_stdout 13:53:11 INFO - Current package versions: 13:53:11 INFO - argparse == 1.2.1 13:53:11 INFO - blessings == 1.6 13:53:11 INFO - blobuploader == 1.2.4 13:53:11 INFO - docopt == 0.6.1 13:53:11 INFO - functools32 == 3.2.3-2 13:53:11 INFO - jsonschema == 2.5.1 13:53:11 INFO - manifestparser == 1.1 13:53:11 INFO - mozInstall == 1.13 13:53:11 INFO - mozcrash == 1.0 13:53:11 INFO - mozdebug == 0.1 13:53:11 INFO - mozdevice == 0.51 13:53:11 INFO - mozfile == 1.2 13:53:11 INFO - mozhttpd == 0.7 13:53:11 INFO - mozinfo == 0.10 13:53:11 INFO - mozleak == 0.1 13:53:11 INFO - mozlog == 3.5 13:53:11 INFO - moznetwork == 0.27 13:53:11 INFO - mozprocess == 0.25 13:53:11 INFO - mozprofile == 0.28 13:53:11 INFO - mozrunner == 6.13 13:53:11 INFO - mozscreenshot == 0.1 13:53:11 INFO - mozsystemmonitor == 0.3 13:53:11 INFO - moztest == 0.8 13:53:11 INFO - mozversion == 1.4 13:53:11 INFO - psutil == 3.1.1 13:53:11 INFO - requests == 1.2.3 13:53:11 INFO - wsgiref == 0.1.2 13:53:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:53:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:53:11 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 0x238b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2554a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fb090>, '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 0x26fbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f5f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1504212552.181106-1619623144', '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 13:53:11 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 13:53:11 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 13:53:11 INFO - Using env: {'DISPLAY': ':0', 13:53:11 INFO - 'HOME': '/home/cltbld', 13:53:11 INFO - 'LANG': 'en_US.UTF-8', 13:53:11 INFO - 'LANGUAGE': 'en_US:en', 13:53:11 INFO - 'LOGNAME': 'cltbld', 13:53:11 INFO - 'MAIL': '/var/mail/cltbld', 13:53:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:53:11 INFO - 'MOZ_NO_REMOTE': '1', 13:53:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:53:11 INFO - 'NO_EM_RESTART': '1', 13:53:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:53:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:53:11 INFO - 'PWD': '/builds/slave/test', 13:53:11 INFO - 'SHELL': '/bin/bash', 13:53:11 INFO - 'SHLVL': '1', 13:53:11 INFO - 'TERM': 'linux', 13:53:11 INFO - 'TMOUT': '86400', 13:53:11 INFO - 'USER': 'cltbld', 13:53:11 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1504212552.181106-1619623144', 13:53:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:53:11 INFO - '_': '/tools/buildbot/bin/python'} 13:53:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:53:11 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)) 13:53:11 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)) 13:53:11 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)) 13:53:11 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)) 13:53:11 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)) 13:53:11 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)) 13:53:11 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)) 13:53:11 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)) 13:53:11 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)) 13:53:11 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 13:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:53:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:53:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:53:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 13:53:12 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)) 13:53:12 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)) 13:53:12 INFO - Installing collected packages: simplejson 13:53:12 INFO - Running setup.py install for simplejson 13:53:12 INFO - building 'simplejson._speedups' extension 13:53:12 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 13:53:13 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 13:53:13 INFO - Successfully installed simplejson 13:53:13 INFO - Cleaning up... 13:53:13 INFO - Return code: 0 13:53:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:53: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')]} 13:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:53: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')]} 13:53:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:53:13 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 0x238b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2554a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fb090>, '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 0x26fbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f5f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1504212552.181106-1619623144', '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 13:53:13 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 13:53:13 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 13:53:13 INFO - Using env: {'DISPLAY': ':0', 13:53:13 INFO - 'HOME': '/home/cltbld', 13:53:13 INFO - 'LANG': 'en_US.UTF-8', 13:53:13 INFO - 'LANGUAGE': 'en_US:en', 13:53:13 INFO - 'LOGNAME': 'cltbld', 13:53:13 INFO - 'MAIL': '/var/mail/cltbld', 13:53:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:53:13 INFO - 'MOZ_NO_REMOTE': '1', 13:53:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:53:13 INFO - 'NO_EM_RESTART': '1', 13:53:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:53:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:53:13 INFO - 'PWD': '/builds/slave/test', 13:53:13 INFO - 'SHELL': '/bin/bash', 13:53:13 INFO - 'SHLVL': '1', 13:53:13 INFO - 'TERM': 'linux', 13:53:13 INFO - 'TMOUT': '86400', 13:53:13 INFO - 'USER': 'cltbld', 13:53:13 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1504212552.181106-1619623144', 13:53:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:53:13 INFO - '_': '/tools/buildbot/bin/python'} 13:53:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:53:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:53:13 INFO - Cleaning up... 13:53:13 INFO - Return code: 0 13:53:13 INFO - Running post-action listener: _resource_record_post_action 13:53:13 INFO - Running post-action listener: _start_resource_monitoring 13:53:13 INFO - Starting resource monitoring. 13:53:13 INFO - [mozharness: 2017-08-31 20:53:13.816989Z] Finished create-virtualenv step (success) 13:53:13 INFO - [mozharness: 2017-08-31 20:53:13.817461Z] Running install step. 13:53:13 INFO - Running pre-action listener: _resource_record_pre_action 13:53:13 INFO - Running main action method: install 13:53:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:53:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:53:14 INFO - Reading from file tmpfile_stdout 13:53:14 INFO - Detecting whether we're running mozinstall >=1.0... 13:53:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:53:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:53:14 INFO - Reading from file tmpfile_stdout 13:53:14 INFO - Output received: 13:53:14 INFO - Usage: mozinstall [options] installer 13:53:14 INFO - Options: 13:53:14 INFO - -h, --help show this help message and exit 13:53:14 INFO - -d DEST, --destination=DEST 13:53:14 INFO - Directory to install application into. [default: 13:53:14 INFO - "/builds/slave/test"] 13:53:14 INFO - --app=APP Application being installed. [default: firefox] 13:53:14 INFO - mkdir: /builds/slave/test/build/application 13:53:14 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'] 13:53:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 13:53:30 INFO - Reading from file tmpfile_stdout 13:53:30 INFO - Output received: 13:53:30 INFO - /builds/slave/test/build/application/firefox/firefox 13:53:30 INFO - Running post-action listener: _resource_record_post_action 13:53:30 INFO - [mozharness: 2017-08-31 20:53:30.790767Z] Finished install step (success) 13:53:30 INFO - [mozharness: 2017-08-31 20:53:30.791106Z] Running setup-mitmproxy step. 13:53:30 INFO - Running pre-action listener: _resource_record_pre_action 13:53:30 INFO - Running main action method: setup_mitmproxy 13:53:30 INFO - Skipping: mitmproxy is not required 13:53:30 INFO - Running post-action listener: _resource_record_post_action 13:53:30 INFO - [mozharness: 2017-08-31 20:53:30.792761Z] Finished setup-mitmproxy step (success) 13:53:30 INFO - [mozharness: 2017-08-31 20:53:30.793071Z] Running run-tests step. 13:53:30 INFO - Running pre-action listener: _resource_record_pre_action 13:53:30 INFO - Running pre-action listener: _set_gcov_prefix 13:53:30 INFO - Running main action method: run_tests 13:53:30 WARNING - Try message not found. 13:53:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:53:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:53:30 INFO - Python 2.7.3 13:53:30 INFO - Return code: 0 13:53:30 INFO - grabbing minidump binary from tooltool 13:53:30 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')]} 13:53:30 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 0x26fb090>, '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 0x26fbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f5f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:53:30 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 13:53:30 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 13:53:30 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 13:53:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:53:30 INFO - Return code: 0 13:53:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:53:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:53:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:53:30 INFO - ENV: RUST_BACKTRACE is now full 13:53:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:53:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:53:30 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/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-084', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:53:30 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/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-084 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:53:30 INFO - Using env: {'DISPLAY': ':0', 13:53:30 INFO - 'HOME': '/home/cltbld', 13:53:30 INFO - 'LANG': 'en_US.UTF-8', 13:53:30 INFO - 'LANGUAGE': 'en_US:en', 13:53:30 INFO - 'LOGNAME': 'cltbld', 13:53:30 INFO - 'MAIL': '/var/mail/cltbld', 13:53:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:53:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:53:30 INFO - 'MOZ_ACCELERATED': '1', 13:53:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:53:30 INFO - 'MOZ_NO_REMOTE': '1', 13:53:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:53:30 INFO - 'MOZ_WEBRENDER': '1', 13:53:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:53:30 INFO - 'NO_EM_RESTART': '1', 13:53:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:53:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:53:30 INFO - 'PWD': '/builds/slave/test', 13:53:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:53:30 INFO - 'RUST_BACKTRACE': 'full', 13:53:30 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:53:30 INFO - 'SHELL': '/bin/bash', 13:53:30 INFO - 'SHLVL': '1', 13:53:30 INFO - 'TERM': 'linux', 13:53:30 INFO - 'TMOUT': '86400', 13:53:30 INFO - 'USER': 'cltbld', 13:53:30 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1504212552.181106-1619623144', 13:53:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:53:30 INFO - '_': '/tools/buildbot/bin/python'} 13:53:30 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/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-084', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:53:31 INFO - mozversion application_buildid: 20170831195811 13:53:31 INFO - mozversion application_changeset: 13d241d08912be31884f9d0d0e805b25343d6c0a 13:53:31 INFO - mozversion application_display_name: Nightly 13:53:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:53:31 INFO - mozversion application_name: Firefox 13:53:31 INFO - mozversion application_remotingname: firefox 13:53:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:53:31 INFO - mozversion application_vendor: Mozilla 13:53:31 INFO - mozversion application_version: 57.0a1 13:53:31 INFO - mozversion platform_buildid: 20170831195811 13:53:31 INFO - mozversion platform_changeset: 13d241d08912be31884f9d0d0e805b25343d6c0a 13:53:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:53:31 INFO - mozversion platform_version: 57.0a1 13:53:31 INFO - using testdate: 1504212811 13:53:31 INFO - actual date: 1504212811 13:53:31 INFO - starting webserver on 'localhost:57358' 13:53:31 INFO - SUITE-START | Running 2 tests 13:53:31 INFO - TEST-START | dromaeo_css 13:53:31 INFO - Initialising browser for dromaeo_css test... 13:53:31 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57358/getInfo.html -profile /tmp/tmptCKOuv/profile 13:53:31 INFO - TEST-INFO | started process 21577 (/builds/slave/test/build/application/firefox/firefox http://localhost:57358/getInfo.html) 13:53:38 INFO - TEST-INFO | 21577: exit 0 13:53:38 INFO - Browser initialized. 13:53:38 INFO - Running cycle 1/1 for dromaeo_css test... 13:53:38 INFO - Using env: {'DISPLAY': ':0', 13:53:38 INFO - 'HOME': '/home/cltbld', 13:53:38 INFO - 'JSGC_DISABLE_POISONING': '1', 13:53:38 INFO - 'LANG': 'en_US.UTF-8', 13:53:38 INFO - 'LANGUAGE': 'en_US:en', 13:53:38 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 13:53:38 INFO - 'LOGNAME': 'cltbld', 13:53:38 INFO - 'MAIL': '/var/mail/cltbld', 13:53:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:53:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:53:38 INFO - 'MOZ_ACCELERATED': '1', 13:53:38 INFO - 'MOZ_CRASHREPORTER': '1', 13:53:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:53:38 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 13:53:38 INFO - 'MOZ_NO_REMOTE': '1', 13:53:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:53:38 INFO - 'MOZ_WEBRENDER': '1', 13:53:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:53:38 INFO - 'NO_EM_RESTART': '1', 13:53:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:53:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:53:38 INFO - 'PWD': '/builds/slave/test', 13:53:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:53:38 INFO - 'RUST_BACKTRACE': 'full', 13:53:38 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:53:38 INFO - 'SHELL': '/bin/bash', 13:53:38 INFO - 'SHLVL': '1', 13:53:38 INFO - 'TERM': 'linux', 13:53:38 INFO - 'TMOUT': '86400', 13:53:38 INFO - 'USER': 'cltbld', 13:53:38 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1504212552.181106-1619623144', 13:53:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:53:38 INFO - '_': '/tools/buildbot/bin/python'} 13:53:38 INFO - TEST-INFO | started process 21772 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptCKOuv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 13:53:39 INFO - PID 21772 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 13:53:39 INFO - PID 21772 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 13:53:39 INFO - PID 21772 | 13:53:39 INFO - PID 21772 | (/builds/slave/test/build/application/firefox/firefox:21834): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 13:53:39 INFO - PID 21772 | 13:53:50 INFO - PID 21772 | RSS: Main: 202436608 13:53:50 INFO - PID 21772 | 13:53:53 INFO - PID 21772 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 13:56:49 INFO - PID 21772 | Cycle 1(1): loaded http://localhost:57358/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57358/tests/dromaeo/cssquery-ext.html) 13:56:51 INFO - PID 21772 | RSS: Main: 212598784 13:56:51 INFO - PID 21772 | 13:59:53 INFO - PID 21772 | Cycle 1(1): loaded http://localhost:57358/tests/dromaeo/cssquery-ext.html (next: http://localhost:57358/tests/dromaeo/cssquery-jquery.html) 13:59:54 INFO - PID 21772 | RSS: Main: 209625088 13:59:54 INFO - PID 21772 | 14:02:56 INFO - PID 21772 | Cycle 1(1): loaded http://localhost:57358/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57358/tests/dromaeo/cssquery-mootools.html) 14:02:56 INFO - PID 21772 | RSS: Main: 215748608 14:02:56 INFO - PID 21772 | 14:05:58 INFO - PID 21772 | Cycle 1(1): loaded http://localhost:57358/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57358/tests/dromaeo/cssquery-prototype.html) 14:05:59 INFO - PID 21772 | RSS: Main: 211603456 14:05:59 INFO - PID 21772 | 14:09:03 INFO - PID 21772 | Cycle 1(1): loaded http://localhost:57358/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57358/tests/dromaeo/cssquery-yui.html) 14:09:03 INFO - PID 21772 | RSS: Main: 212459520 14:09:03 INFO - PID 21772 | 14:12:06 INFO - PID 21772 | Cycle 1(1): loaded http://localhost:57358/tests/dromaeo/cssquery-yui.html (next: http://localhost:57358/tests/dromaeo/cssquery-dojo.html) 14:12:06 INFO - PID 21772 | RSS: Main: 215777280 14:12:06 INFO - PID 21772 | 14:12:06 INFO - PID 21772 | __start_tp_report 14:12:06 INFO - PID 21772 | _x_x_mozilla_page_load 14:12:06 INFO - PID 21772 | _x_x_mozilla_page_load_details 14:12:06 INFO - PID 21772 | |i|pagename|runs| 14:12:06 INFO - PID 21772 | |0;dojo.html;3241.011491495093;3286.244163842318;3299.1257316811048;3302.4220761366755;3337.8331083445823;6196.876062478747;6219.222597175353;6222.066689996503;6267.153934218879;6299.401556852097;6157.1995640566665;6233.501319894409;6246.750129994806;6261.592996455227;6268.404501572343;5762.4525670061485;5800.651960882361;5840.094785308284;5880.206172166745;5924.348321684612;5837.532997360201;5857.3849745776715;5928.851778705523;5943.940560594404;5950.196723442323;5788.095826129908;5792.68140252286;5845.06478963368;5868.970655146718;5926.051831706928;5654.886902261932;5778.711064446761;5788.450097240755;5812.534997200214;5850.853728656818;5799.246098007275;5830.3586605473365;5865.853353666193;5870.354261031283;5870.530357571427;6259.37406259375;6279.717412716439;6298.842528936768;6348.746050157988;6387.904181437236;6556.803295901131;6687.598744075371;6694.364035416676;6715.496337774637;6779.084823548807;6719.596824190564;6722.966385168092;6760.864782704319;6781.966090169567;6785.898211526782;6219.782307619212;6231.719572619198;6294.779682711083;6309.085182648536;6320.241571011462;6770.526063175629;6869.003994420881;6898.2756810535175;6905.309469053054;6935.6878940447805;6605.438537724347;6618.371254730793;6627.403533681992;6628.270890202074;6643.302453242437;6496.967515162489;6618.933810661832;6641.933580664131;6703.966480167568;6799.728010879509;6637.1703537057865;6691.26396096429;6718.764843230561;6731.932680673229;6759.594424334556;6715.93284067153;6721.1598550181225;6792.524523283323;6808.148981377328;6837.760678376233;5194.22086687;5264.42091369949;5269.525742683177;5273.446288139767;5277.155655095166;4509.639228861749;4585.633149348044;4627.838025669085;4661.790219440133;4678.415198100238;5826.242588463558;5844.853878653068;5860.413958604106;5860.882782344329;5864.03243464832;6720.865582688319;6739.831504212336;6790.456763458911;6808.148981377328;6817.079694241214;5818.301803783488;5819.039858423313;5878;5897.085951677411;5910.143029260733;5675.631083979528;5726.226959360516;5745.770169193185;5815.651060936358;5825.155352473867;6516.934830651728;6562.967185164043;6609.735610575619;6637.1703537057865;6644.833879152963;6810.8637827244165;6851.794446166623;6852.383285504129;6875.828104297432;6917.066196063668;6584.50616203777;6652.83367915806;6667.833304167435;6677.232118306457;6712.932870671426;6579.046038324512;6668.533202675766;6691.46468282546;6751.966240168767;6764.830879228059;6683.231428385798;6715.7985260442265;6810.216825065181;6818.147731533559;6829.6243706596615;6513.8697226056165;6546.0508226307875;6548.901766473602;6598.076269322202;6600.141981542561;6542.640154791532;6556.934430655632;6559.672016399257;6577.4409175218725;6596.439302659328;6500.447461965786;6503.674816259263;6513.1532900722605;6539.869202616016;6561.278259391368;6470.6117632940295;6619.437347825488;6640.07039014548;6692.498062645223;6694.933050669431;6268.905966410416;6331.746730130927;6354.555181137461;6363.109164717036;6378.107065010995 14:12:06 INFO - PID 21772 | |1;ext.html;767.842592268585;844.2444012608714;866.3848667446115;868.5613765048649;1100.895414935581;29023.419531609354;30562.23594410138;39954.60045399549;40447;40561;40902;41502.79248603753;41631;41700;41708.58291417085;7487.1764105948305;7556.055493063367;7594.620268986556;7615.276548727889;7621.314081732643;5731.770729170828;5869.530437564985;7468.365188958918;7516.624168791566;7731.884021739678;7641.6943322267325;7766.650500727453;7770.41721870862;7773.494722843026;7774.572398518079;7654.693812247503;7697.153313135578;7724.961375193145;7726.729564465217;7727.034120734852;7518.022657054548;7535.095788505414;7557.886631700474;7577.052868391451;7599.316061554431;36549;36799.264014719825;36839;36906;36950.81524592387;3452.430348992413;3496.0385893879134;3511.9297614047578;3518.1908161123083;3521.506989021539;30526.847365763027;30594;30654;30707.846460767778;30722.38555228905;4968.130577148984;5154.690718556899;5154.845354639367;5159.509846564571;5203.973980130113;180283;181736;181891;182408.08795956068;182766.08616956964;46753.766231169306;46802.531974680496;46818.5318146821;46860.297095543596;46874;49200.50799492031;50067;51031.744841275555;51414.22878656823;51421.48578514242;14989.775153372708;15083.868709846805;15134.470293539673;15154.772678409832;15163.620909477351;12049.397530123459;12281.385930703429;12317.630471085882;12328.50685972569;12480.500779968881;13698.794518082237;13710.931445342909;13739.656508587166;13749;13774.724505509834;5409;5525.4474552545225;5545.417731138253;5569.916451253234;5616.66300022;1008.8335424654997;1017.6438246613774;1025.2566889005561;1035.8135535603665;1039.443897514826;23008.53982920332;23060.769392306196;23158.1894633687;23295.650565241536;23616;1070.7644318249972;1124.2860783402434;1128.074978517624;1128.6275529075385;1130.2145009218514;11775;12064.155509114453;12226.449809758582;12248.326342051094;15803.288852001688;220256;223318;223812;224011;224111;53346.73326633342;53426.73286633542;53919.73040134774;54051.45948540543;54288.185677214875;1418.978715319271;1433.4982756035304;1445.3062529985666;1460.4377314733692;1466.9266536673338;26755.464890702468;27020;27131;27138;27141.321466962694;36713;36870;36896.81551592225;36906.81546592357;36940;197468;200193;200585;200619;201581;25700.8714956424;28474.43051138924;30743;31710.68289317077;31780.20549486189;40178.59821401749;40426;40437.1912561753;40602.39096413615;40962.590374095875;29571.704282957755;29580.852095739385;29796;29942.401151976403;30982.535261971538;30141.36889884222;30303.242418939702;30396.93610723614;30658.436213991663;30825.383492330475;33337.499937501445;33418.331633367685;33481.16297092592;33522.16194595155;36646.816765917065;32419.513707293936;32444.513332300507;32546.511802323457;33183.668163318056;33500.83249583736;23773.167939122046;23952.40118997039;24622.507549849262;24655.753442465346;24837.50324993454 14:12:06 INFO - PID 21772 | |2;jquery.html;568.1279236372167;569.2542768972644;569.2872029187106;574.482965331202;589.6138029590618;21454.570908581838;22347.10611575537;22489.775102248972;22523.54952900941;22555.097796088157;23564.64653030206;25853;25905.740942590568;25954.610680839804;26122.6081608776;6616.106825578558;6778.728850845961;6796.830079248034;6803.897941530881;6804.965975170142;6264.749410023594;6631.568948018387;6652;6655.900161497581;6680.832979175535;6569.507286953473;6593.340665933416;6613.966930165342;6618.238902526199;6626.9668651656675;6556.541042127053;6602.8349291268105;6617.205935287772;6625.503087268474;6626.966865165691;6075.362086980847;6089.939100608982;6098.664573448458;6125;6138.84652883677;25141.37146571332;28863.855680721674;29334;29359.55960660592;29392;2055.989720051405;2086.791320867916;2087.217293514932;2087.895605219748;2091.1217288738612;19548.609027819508;19827.30604428838;19858.801411985984;19900.104495297746;19922.402327930184;2338.1933233034574;2384.6542251373453;2387.4270175158013;2408.542376948392;2437.890294936732;134201;134296.32851835777;137528.31235843856;137618;138686;13904.58286251414;14520.927395362956;14627.26863656813;14632.195229262492;15000.924995375171;23235.883820580788;23359.7664023361;23390.415239618804;23392.415189620395;23420.18029368964;9676;9814.901850981541;9820.803583928282;9845.212383009342;10050.040242152856;8967.417117887317;9061.54692265384;9089.591113377437;9121.45271283725;9218.078192180863;7601.277878601524;9022.819543609223;9111.407758495676;9348.766280843034;9376;2631.5921032240035;2640.5775075988136;2668.6664166979126;2756.8483733394455;2791.3579876628487;940.7083804020775;959.1894848852709;969.2488321550713;990.6681261777385;996.5366104761321;18662.160202790634;18874.245030198912;19015.04924753757;19241.711374329396;19579.902100489406;1002.9899701003043;1038.8285932821;1060.9787804244027;1073.9946300268605;1076.4402510694395;10483.895161048444;10892.346459212315;11052.834207486894;11111.555537778399;11160.10719142483;502371;502619;505697;521643;528627;114326.42836785763;119241;122553;123194;123299;1209.4859684633996;1266.4997326056157;1274.8597654258024;1276.789329760579;1277.0166971432132;20890.268840591114;20927.8953605231;20953.26663566829;21411.929403529448;21490.892545537172;56876;57242;57749;58706.706466467396;59552.70223648854;71724;72013.6399318;72244.83265502044;72487;73133.634331828;14152.646183845487;14322.355494002586;14340.784888226477;14347;14366.281685915872;16622.833771662128;22691.886540567193;22906;23147.07411703513;23373.532529349657;18087.728684070014;18409.98745069034;18446.35437759672;18464;18610.813891860907;16901;16908.66182676315;17212.741808872626;17505.474835754947;17644.82355176432;19728;19965.700514492004;19969.400917972485;20024.299149529696;20148.697769533177;14578.927105364406;14650.560483185522;14838.629034274229;14894.106353618818;15019.32413041394;18644.254229830654;18820.52948676294;18901.149448274584;18997.62004759925;19358.128884199963 14:12:06 INFO - PID 21772 | |3;mootools.html;1298.22755460501;1349.946002159913;1363.1616555818175;1368.1517459175313;1374.285371606764;14682;15255.618609534768;15289.770653440193;15419.845801541982;15426.69146617067;15217.695646087072;15630.687386252297;15676.529704108867;15691.293891774869;15737.685246295066;2780.791440641955;2850.44416338814;2855.200543847726;2874.2095923620964;2876.697946715596;2608;2704;2768.3632764464187;2801.271669365959;2802.4395120975782;2809.9157025289273;2822.6895041545413;2828.2363761784304;2852.5578535326954;2859.5567687008547;2556.118139241968;2585.870706464669;2591.067215802319;2595.2084614192663;2703.1214855172047;2634.907778227772;2680.289723223347;2684.8254863433813;2687.3953360493733;2692.851893145876;14849.183294918776;15063.698726025417;15167.165805880672;15283.235838208046;15309.234538273153;7766.922330776676;8032.236937490929;8046.637901294456;8049.3962952778775;8061.677532898677;5063.772130254148;5083.3391659084455;5362.088444964365;5368.946310536923;5431.4840090191365;1777.2624360890215;1786.5265704588294;1815.9636807263912;1842.7051671732593;1852.8425083867887;26519.73480265192;27008.594871076948;27011.594826077624;27021.324466888287;27108.45783084347;6949.687264073129;6965.582065076112;6985.196702379189;7072;7112.14654241484;17095.743563846554;17106.828931710774;17156.571085722957;17182.65634687299;17210;7568.318851303409;7682.423818213656;7731.0336207974005;7743.651535680908;7757.495762775401;7014.263502332284;7147.1780745214965;7271.709131634781;7460.0674915635545;7494.325510704063;5228.346456692913;5409.269748583891;5442.782288708408;5451.672899626035;5466.644668096561;1347.2253454263837;1366.9453221871213;1539.5612250508552;1563.523125446727;1590.864776494011;917.3211823250747;934.8784657994553;947.5309721687809;948.2177203806887;948.6964171465203;8505.192006759347;8701.17338852808;8715.389922705477;8764.8685269721;8796.736097917073;981.1415011864618;1010.3634710132569;1011.2870426349406;1014.8274793285011;1019.3068713274896;5219.781587845397;5398.13629819227;5462.890742185214;5492.395836457987;5725.456081672234;21018.369448916557;21898;22096.2266320678;22184.667229991563;22330.441738956655;20184.394468165978;21343.573128537344;21529.569408612053;21586.78413215879;21697.24059657936;10822.67531974042;11340.376279304717;11345.205835591429;11354.48904799286;11449.54201831934;8044.034715834137;8414.87377689323;8419.494830310201;8426.536540490331;8588.699395521377;18690.532736681693;18859.339923102627;18996.620067598848;19260;19424.708629370853;18784.90607547008;19172.808271917103;19322.516937076685;19429.319973800848;20320;11961.461734221806;12049.277043377426;12073.75852482963;12135.393230338625;12141.878581214074;14057.367418466398;14140.646483837987;14219.786703199254;14241.928790355982;14370;11424.82862757076;11547.653570392566;11552.826707599224;11569.710757231136;11784.057275417774;10972.177086718688;11249.156313276373;11251.437428128724;11282.887171128184;11374.772504549697;9568.808623827344;9590.232781377612;9766.267529935141;9800.11798938099;9801;7028.894566581607;7153.3919616833155;7177.856442871009;7234.276572342724;7337.59643219628;6781.0845535854005;6824.112865327475;6909.205441374306;6917.169939607078;7015.929840701528 14:12:06 INFO - PID 21772 | |4;prototype.html;498.5189292332898;503.35067762586266;527.3724268120933;538.2357052984761;541.8239072301501;6265.216847894013;6266.086269884503;6310.305866354709;6362.236531616201;6365.522585806066;5964.970175149118;6131.8773624527485;6156.507479401648;6206.472449841757;6263.812085637438;4956.876078098058;4975.850724478271;5003.849884503471;5029;5075;4905.681130726492;4968.403791545002;4975.353204083464;5018.64869459138;5040.790210349508;4866;4955.679694604605;4970;4984.252362145689;5016.770891131678;4976.079425306312;4991.700497970133;5021.648484606098;5036.445990940993;5043.646944713872;4440.822367105312;4473.127740090684;4485.775711214426;4492.483364413101;4510.436195475566;6054.182685337511;6078.422549857756;6081.817545473598;6102.169349195224;6133.1413602095745;5650.915236271459;5656.151577263443;5727.570432217601;5738.368779434259;5760.308762948473;6575.342465753434;6579.868402631969;6587.538872278942;6614;6634.469242460592;4829.1548978928895;4842.685225460369;4886.364772579577;4886.877828054327;4889.902201955976;6815;6885.380315771605;6905.37851593354;6938.41023513002;6962.2341542430295;4972.204447288416;4998.400191976986;5028.296038554606;5031.396232452129;5043.3191519145175;5084.576418515915;5110.872228194251;5121.411037730634;5123.7438128093445;5135.12702840518;5603.7758489659955;5692.206954809222;5701.144828275792;5732.426757324234;5734.426557344233;6486.2216534016225;6497.512686548528;6512.283648798629;6554.7378104876225;6587.703553340111;1721;1731.212298404223;1756.1482680899753;1760.4718584424622;1769.2392271323197;1120.8767035626074;1149.8850114988434;1159.3739380734478;1198.964031079069;1243.1670780577035;5653.830385088454;5690.260266165372;5695;5701.942980570141;5727;6319.273283572356;6496.935030649633;6555.901661475082;6605.76879809214;6659.733610655519;5625.521830644359;5636.661800291996;5668.57485688575;5691.9146212806845;5694.430556944355;3480.164760457472;3524.242287908112;3555.7333200010103;3563.2517171394297;3582.229820588586;6421.646809425526;6472.013387616436;6473.935260647333;6504.609723416515;6505;6732;6808.659567021629;6901.896471552931;6942.51402401827;6981.89527157093;6441.967790161019;6500.772472963518;6532.98221593726;6576.309487503743;6601.636909969998;6629.2376376715365;6632.801015969529;6709.832254193684;6723.495737819585;6778.389944904785;6580.782555227298;6625.834354141185;6635.601863888182;6669.233038200669;6703.430208432338;6482.157319548429;6518.706658200297;6520.445762110274;6601.636909969998;6641.900371494528;4967.453580106113;4981.701097934136;4989.351384320015;5049.2426136079885;5063.3417655704525;6633.867322653617;6671.532992690465;6792.4792199487065;6806.18325800907;6831.9658401707675;6480.44916182111;6560.950247960303;6562.77030303937;6565.310642382672;6566.474682025522;6460.86647975722;6501.707423165874;6519.315471875385;6549.869002619826;6630.90053649186;6337.873242535031;6397.712102955285;6400.871982560416;6432.807015789534;6532.510061745293;6208.286047104641;6529.51028672861;6602.66986650656;6706.138049913773;6719.664016799238;6239.500839932885;6331.145295385064;6372.458341040878;6389.2971773105855;6448.387403196689 14:12:06 INFO - PID 21772 | |5;yui.html;896.7040876510752;896.896856861461;917.7889085510333;922.9446233226003;924.1497822003756;15527.146006969611;16272.837271627295;16302.184890755474;19779.703304450446;20772.272970446036;20224.8988755056;20407.795922040776;21182.89408552955;21400.35798926031;21506.60207086542;958.5686441101515;981.68095369005;989.7228775942748;990.6631745206628;997.3367710472563;950.6530116507494;1009.3741880034353;1012.2003617142449;1012.4785735346265;1014.031599822168;1045.2474218562622;1063.3301020357203;1064.7817197474537;1066.4347895615335;1068.5405275731432;1052.8526006359077;1059.369675043352;1062.1874266186373;1062.7449412141107;1066.2696053203542;770.96916123355;773.6673230510878;773.8258891749367;774.7017398301638;775.97672069838;18612;19113.904430477898;19161.13774880134;19273.518162045923;19537.609247815108;20277.594448110955;20801.58396832055;20852.895735521226;20868.582628347347;20880.164793408247;16608.584785380463;16999.830001700073;17006.659866802718;17029.914850425794;17032.296770322868;3625.8187090645624;3683.797391143486;3686.705063594906;3690.4833323334756;3692.46459263408;125482;128782;129191.35404323012;130707;130745;15562;15674.373025079098;15853.920730396274;15977.840221597635;16064;27577.17268481949;28655.283617909718;29036.7096329034;29045.709542904722;29760.702392976225;7946.801329966682;7956.721514746956;7962.163972782774;7984.560849153352;8040.557769322626;3966.643002129764;4072.470578824793;4103.794810259535;4111.301078816608;4115.238680844053;5162.6902385856965;5261.289725886956;5380;5381.67709937405;5389;926.666400095965;951.3816019587185;958.2525630008604;966.8888077871135;967.6129548180784;536.4796147736768;633.7084940927133;656.2059907511868;658.805652332563;674.0798809624827;11037.558497660164;11309.321440713584;11493.655190344303;11868.347240901661;12131.636050918487;627.6547898655813;635.7488791927162;637.6907200007993;642.6722371590522;648.4779752299349;5424.783008679608;5434.456554344534;5662.462066103713;5701.144828275792;5723.713814309268;98664;105728.47135764272;105886.47056764667;111150.44424777986;111873;95178;95804.52097739467;96864;97367.51316243374;97575;81656.59171704222;81771;84516.57741711252;85062.5746871274;86877.62051241155;9483.099105584959;9550.95224523873;9591.520423978913;9777.364471309342;9806.607735690777;38453;39206.21587568176;39310.0344982744;39870.80064599658;40177;51812;51990.220146698586;53213;53321.46678533165;53406;14728.852711472748;14802.407903683732;14932.7760083601;16023.759643605588;16578.58553536171;19133.712994304817;19493.61012779765;19502.8049719501;19558.511037224183;19662.90168549148;17285;17735.556611084827;18058.729119062962;18121.637567248847;18149.183286751864;16746.916265418597;17055.914720426317;17521.56196095108;17853.821461785217;17910.820891790914;15889.841101588836;16329.101899395648;16531.504054878373;16654.750178747086;16752.162391880112;11761.647150585497;11793.115516336138;12282.38588070575;12285.078619103424;12728.427220774902;13278;13632.591022269347;13701;13721.970852185927;13731.313434328444 14:12:06 INFO - PID 21772 | __end_tp_report 14:12:06 INFO - PID 21772 | __start_cc_report 14:12:06 INFO - PID 21772 | _x_x_mozilla_cycle_collect,372 14:12:06 INFO - PID 21772 | __end_cc_report 14:12:06 INFO - PID 21772 | __startTimestamp1504213926274__endTimestamp 14:12:06 INFO - PID 21772 | 14:12:06 INFO - PID 21772 | ------- Summary: start ------- 14:12:06 INFO - PID 21772 | Number of tests: 6 14:12:06 INFO - PID 21772 | 14:12:06 INFO - PID 21772 | [#0] dojo.html Cycles:165 Average:6210.82 Median:6500.45 stddev:725.79 (11.2%) stddev-sans-first:689.61 14:12:06 INFO - PID 21772 | Values: 3241.0 3286.2 3299.1 3302.4 3337.8 6196.9 6219.2 6222.1 6267.2 6299.4 6157.2 6233.5 6246.8 6261.6 6268.4 5762.5 5800.7 5840.1 5880.2 5924.3 5837.5 5857.4 5928.9 5943.9 5950.2 5788.1 5792.7 5845.1 5869.0 5926.1 5654.9 5778.7 5788.5 5812.5 5850.9 5799.2 5830.4 5865.9 5870.4 5870.5 6259.4 6279.7 6298.8 6348.7 6387.9 6556.8 6687.6 6694.4 6715.5 6779.1 6719.6 6723.0 6760.9 6782.0 6785.9 6219.8 6231.7 6294.8 6309.1 6320.2 6770.5 6869.0 6898.3 6905.3 6935.7 6605.4 6618.4 6627.4 6628.3 6643.3 6497.0 6618.9 6641.9 6704.0 6799.7 6637.2 6691.3 6718.8 6731.9 6759.6 6715.9 6721.2 6792.5 6808.1 6837.8 5194.2 5264.4 5269.5 5273.4 5277.2 4509.6 4585.6 4627.8 4661.8 4678.4 5826.2 5844.9 5860.4 5860.9 5864.0 6720.9 6739.8 6790.5 6808.1 6817.1 5818.3 5819.0 5878.0 5897.1 5910.1 5675.6 5726.2 5745.8 5815.7 5825.2 6516.9 6563.0 6609.7 6637.2 6644.8 6810.9 6851.8 6852.4 6875.8 6917.1 6584.5 6652.8 6667.8 6677.2 6712.9 6579.0 6668.5 6691.5 6752.0 6764.8 6683.2 6715.8 6810.2 6818.1 6829.6 6513.9 6546.1 6548.9 6598.1 6600.1 6542.6 6556.9 6559.7 6577.4 6596.4 6500.4 6503.7 6513.2 6539.9 6561.3 6470.6 6619.4 6640.1 6692.5 6694.9 6268.9 6331.7 6354.6 6363.1 6378.1 14:12:06 INFO - PID 21772 | 14:12:06 INFO - PID 21772 | [#1] ext.html Cycles:180 Average:36677.59 Median:32865.09 stddev:52414.04 (159.5%) stddev-sans-first:52491.72 14:12:06 INFO - PID 21772 | Values: 767.8 844.2 866.4 868.6 1100.9 29023.4 30562.2 39954.6 40447.0 40561.0 40902.0 41502.8 41631.0 41700.0 41708.6 7487.2 7556.1 7594.6 7615.3 7621.3 5731.8 5869.5 7468.4 7516.6 7731.9 7641.7 7766.7 7770.4 7773.5 7774.6 7654.7 7697.2 7725.0 7726.7 7727.0 7518.0 7535.1 7557.9 7577.1 7599.3 36549.0 36799.3 36839.0 36906.0 36950.8 3452.4 3496.0 3511.9 3518.2 3521.5 30526.8 30594.0 30654.0 30707.8 30722.4 4968.1 5154.7 5154.8 5159.5 5204.0 180283.0 181736.0 181891.0 182408.1 182766.1 46753.8 46802.5 46818.5 46860.3 46874.0 49200.5 50067.0 51031.7 51414.2 51421.5 14989.8 15083.9 15134.5 15154.8 15163.6 12049.4 12281.4 12317.6 12328.5 12480.5 13698.8 13710.9 13739.7 13749.0 13774.7 5409.0 5525.4 5545.4 5569.9 5616.7 1008.8 1017.6 1025.3 1035.8 1039.4 23008.5 23060.8 23158.2 23295.7 23616.0 1070.8 1124.3 1128.1 1128.6 1130.2 11775.0 12064.2 12226.4 12248.3 15803.3 220256.0 223318.0 223812.0 224011.0 224111.0 53346.7 53426.7 53919.7 54051.5 54288.2 1419.0 1433.5 1445.3 1460.4 1466.9 26755.5 27020.0 27131.0 27138.0 27141.3 36713.0 36870.0 36896.8 36906.8 36940.0 197468.0 200193.0 200585.0 200619.0 201581.0 25700.9 28474.4 30743.0 31710.7 31780.2 40178.6 40426.0 40437.2 40602.4 40962.6 29571.7 29580.9 29796.0 29942.4 30982.5 30141.4 30303.2 30396.9 30658.4 30825.4 33337.5 33418.3 33481.2 33522.2 36646.8 32419.5 32444.5 32546.5 33183.7 33500.8 23773.2 23952.4 24622.5 24655.8 24837.5 14:12:06 INFO - PID 21772 | 14:12:06 INFO - PID 21772 | [#2] jquery.html Cycles:180 Average:35596.18 Median:23297.83 stddev:86106.43 (369.6%) stddev-sans-first:86307.82 14:12:06 INFO - PID 21772 | Values: 568.1 569.3 569.3 574.5 589.6 21454.6 22347.1 22489.8 22523.5 22555.1 23564.6 25853.0 25905.7 25954.6 26122.6 6616.1 6778.7 6796.8 6803.9 6805.0 6264.7 6631.6 6652.0 6655.9 6680.8 6569.5 6593.3 6614.0 6618.2 6627.0 6556.5 6602.8 6617.2 6625.5 6627.0 6075.4 6089.9 6098.7 6125.0 6138.8 25141.4 28863.9 29334.0 29359.6 29392.0 2056.0 2086.8 2087.2 2087.9 2091.1 19548.6 19827.3 19858.8 19900.1 19922.4 2338.2 2384.7 2387.4 2408.5 2437.9 134201.0 134296.3 137528.3 137618.0 138686.0 13904.6 14520.9 14627.3 14632.2 15000.9 23235.9 23359.8 23390.4 23392.4 23420.2 9676.0 9814.9 9820.8 9845.2 10050.0 8967.4 9061.5 9089.6 9121.5 9218.1 7601.3 9022.8 9111.4 9348.8 9376.0 2631.6 2640.6 2668.7 2756.8 2791.4 940.7 959.2 969.2 990.7 996.5 18662.2 18874.2 19015.0 19241.7 19579.9 1003.0 1038.8 1061.0 1074.0 1076.4 10483.9 10892.3 11052.8 11111.6 11160.1 502371.0 502619.0 505697.0 521643.0 528627.0 114326.4 119241.0 122553.0 123194.0 123299.0 1209.5 1266.5 1274.9 1276.8 1277.0 20890.3 20927.9 20953.3 21411.9 21490.9 56876.0 57242.0 57749.0 58706.7 59552.7 71724.0 72013.6 72244.8 72487.0 73133.6 14152.6 14322.4 14340.8 14347.0 14366.3 16622.8 22691.9 22906.0 23147.1 23373.5 18087.7 18410.0 18446.4 18464.0 18610.8 16901.0 16908.7 17212.7 17505.5 17644.8 19728.0 19965.7 19969.4 20024.3 20148.7 14578.9 14650.6 14838.6 14894.1 15019.3 18644.3 18820.5 18901.1 18997.6 19358.1 14:12:06 INFO - PID 21772 | 14:12:06 INFO - PID 21772 | [#3] mootools.html Cycles:180 Average:9423.58 Median:14600.01 stddev:6750.62 (46.2%) stddev-sans-first:6741.95 14:12:06 INFO - PID 21772 | Values: 1298.2 1349.9 1363.2 1368.2 1374.3 14682.0 15255.6 15289.8 15419.8 15426.7 15217.7 15630.7 15676.5 15691.3 15737.7 2780.8 2850.4 2855.2 2874.2 2876.7 2608.0 2704.0 2768.4 2801.3 2802.4 2809.9 2822.7 2828.2 2852.6 2859.6 2556.1 2585.9 2591.1 2595.2 2703.1 2634.9 2680.3 2684.8 2687.4 2692.9 14849.2 15063.7 15167.2 15283.2 15309.2 7766.9 8032.2 8046.6 8049.4 8061.7 5063.8 5083.3 5362.1 5368.9 5431.5 1777.3 1786.5 1816.0 1842.7 1852.8 26519.7 27008.6 27011.6 27021.3 27108.5 6949.7 6965.6 6985.2 7072.0 7112.1 17095.7 17106.8 17156.6 17182.7 17210.0 7568.3 7682.4 7731.0 7743.7 7757.5 7014.3 7147.2 7271.7 7460.1 7494.3 5228.3 5409.3 5442.8 5451.7 5466.6 1347.2 1366.9 1539.6 1563.5 1590.9 917.3 934.9 947.5 948.2 948.7 8505.2 8701.2 8715.4 8764.9 8796.7 981.1 1010.4 1011.3 1014.8 1019.3 5219.8 5398.1 5462.9 5492.4 5725.5 21018.4 21898.0 22096.2 22184.7 22330.4 20184.4 21343.6 21529.6 21586.8 21697.2 10822.7 11340.4 11345.2 11354.5 11449.5 8044.0 8414.9 8419.5 8426.5 8588.7 18690.5 18859.3 18996.6 19260.0 19424.7 18784.9 19172.8 19322.5 19429.3 20320.0 11961.5 12049.3 12073.8 12135.4 12141.9 14057.4 14140.6 14219.8 14241.9 14370.0 11424.8 11547.7 11552.8 11569.7 11784.1 10972.2 11249.2 11251.4 11282.9 11374.8 9568.8 9590.2 9766.3 9800.1 9801.0 7028.9 7153.4 7177.9 7234.3 7337.6 6781.1 6824.1 6909.2 6917.2 7015.9 14:12:06 INFO - PID 21772 | 14:12:06 INFO - PID 21772 | [#4] prototype.html Cycles:180 Average:5506.16 Median:6132.51 stddev:1546.67 (25.2%) stddev-sans-first:1504.65 14:12:06 INFO - PID 21772 | Values: 498.5 503.4 527.4 538.2 541.8 6265.2 6266.1 6310.3 6362.2 6365.5 5965.0 6131.9 6156.5 6206.5 6263.8 4956.9 4975.9 5003.8 5029.0 5075.0 4905.7 4968.4 4975.4 5018.6 5040.8 4866.0 4955.7 4970.0 4984.3 5016.8 4976.1 4991.7 5021.6 5036.4 5043.6 4440.8 4473.1 4485.8 4492.5 4510.4 6054.2 6078.4 6081.8 6102.2 6133.1 5650.9 5656.2 5727.6 5738.4 5760.3 6575.3 6579.9 6587.5 6614.0 6634.5 4829.2 4842.7 4886.4 4886.9 4889.9 6815.0 6885.4 6905.4 6938.4 6962.2 4972.2 4998.4 5028.3 5031.4 5043.3 5084.6 5110.9 5121.4 5123.7 5135.1 5603.8 5692.2 5701.1 5732.4 5734.4 6486.2 6497.5 6512.3 6554.7 6587.7 1721.0 1731.2 1756.1 1760.5 1769.2 1120.9 1149.9 1159.4 1199.0 1243.2 5653.8 5690.3 5695.0 5701.9 5727.0 6319.3 6496.9 6555.9 6605.8 6659.7 5625.5 5636.7 5668.6 5691.9 5694.4 3480.2 3524.2 3555.7 3563.3 3582.2 6421.6 6472.0 6473.9 6504.6 6505.0 6732.0 6808.7 6901.9 6942.5 6981.9 6442.0 6500.8 6533.0 6576.3 6601.6 6629.2 6632.8 6709.8 6723.5 6778.4 6580.8 6625.8 6635.6 6669.2 6703.4 6482.2 6518.7 6520.4 6601.6 6641.9 4967.5 4981.7 4989.4 5049.2 5063.3 6633.9 6671.5 6792.5 6806.2 6832.0 6480.4 6561.0 6562.8 6565.3 6566.5 6460.9 6501.7 6519.3 6549.9 6630.9 6337.9 6397.7 6400.9 6432.8 6532.5 6208.3 6529.5 6602.7 6706.1 6719.7 6239.5 6331.1 6372.5 6389.3 6448.4 14:12:06 INFO - PID 21772 | 14:12:06 INFO - PID 21772 | [#5] yui.html Cycles:180 Average:22686.13 Median:21291.63 stddev:31437.37 (147.7%) stddev-sans-first:31482.98 14:12:06 INFO - PID 21772 | Values: 896.7 896.9 917.8 922.9 924.1 15527.1 16272.8 16302.2 19779.7 20772.3 20224.9 20407.8 21182.9 21400.4 21506.6 958.6 981.7 989.7 990.7 997.3 950.7 1009.4 1012.2 1012.5 1014.0 1045.2 1063.3 1064.8 1066.4 1068.5 1052.9 1059.4 1062.2 1062.7 1066.3 771.0 773.7 773.8 774.7 776.0 18612.0 19113.9 19161.1 19273.5 19537.6 20277.6 20801.6 20852.9 20868.6 20880.2 16608.6 16999.8 17006.7 17029.9 17032.3 3625.8 3683.8 3686.7 3690.5 3692.5 125482.0 128782.0 129191.4 130707.0 130745.0 15562.0 15674.4 15853.9 15977.8 16064.0 27577.2 28655.3 29036.7 29045.7 29760.7 7946.8 7956.7 7962.2 7984.6 8040.6 3966.6 4072.5 4103.8 4111.3 4115.2 5162.7 5261.3 5380.0 5381.7 5389.0 926.7 951.4 958.3 966.9 967.6 536.5 633.7 656.2 658.8 674.1 11037.6 11309.3 11493.7 11868.3 12131.6 627.7 635.7 637.7 642.7 648.5 5424.8 5434.5 5662.5 5701.1 5723.7 98664.0 105728.5 105886.5 111150.4 111873.0 95178.0 95804.5 96864.0 97367.5 97575.0 81656.6 81771.0 84516.6 85062.6 86877.6 9483.1 9551.0 9591.5 9777.4 9806.6 38453.0 39206.2 39310.0 39870.8 40177.0 51812.0 51990.2 53213.0 53321.5 53406.0 14728.9 14802.4 14932.8 16023.8 16578.6 19133.7 19493.6 19502.8 19558.5 19662.9 17285.0 17735.6 18058.7 18121.6 18149.2 16746.9 17055.9 17521.6 17853.8 17910.8 15889.8 16329.1 16531.5 16654.8 16752.2 11761.6 11793.1 12282.4 12285.1 12728.4 13278.0 13632.6 13701.0 13722.0 13731.3 14:12:06 INFO - PID 21772 | -------- Summary: end -------- 14:12:06 INFO - PID 21772 | 14:12:07 INFO - TEST-INFO | 21772: exit 0 14:12:07 INFO - TEST-OK | dromaeo_css | took 1116287ms 14:12:07 INFO - TEST-START | kraken 14:12:07 INFO - Initialising browser for kraken test... 14:12:07 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57358/getInfo.html -profile /tmp/tmpJEQTqb/profile 14:12:07 INFO - TEST-INFO | started process 22159 (/builds/slave/test/build/application/firefox/firefox http://localhost:57358/getInfo.html) 14:12:13 INFO - TEST-INFO | 22159: exit 0 14:12:14 INFO - Browser initialized. 14:12:14 INFO - Running cycle 1/1 for kraken test... 14:12:14 INFO - Using env: {'DISPLAY': ':0', 14:12:14 INFO - 'HOME': '/home/cltbld', 14:12:14 INFO - 'JSGC_DISABLE_POISONING': '1', 14:12:14 INFO - 'LANG': 'en_US.UTF-8', 14:12:14 INFO - 'LANGUAGE': 'en_US:en', 14:12:14 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 14:12:14 INFO - 'LOGNAME': 'cltbld', 14:12:14 INFO - 'MAIL': '/var/mail/cltbld', 14:12:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:12:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:12:14 INFO - 'MOZ_ACCELERATED': '1', 14:12:14 INFO - 'MOZ_CRASHREPORTER': '1', 14:12:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:14 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 14:12:14 INFO - 'MOZ_NO_REMOTE': '1', 14:12:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:12:14 INFO - 'MOZ_WEBRENDER': '1', 14:12:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:14 INFO - 'NO_EM_RESTART': '1', 14:12:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:14 INFO - 'PWD': '/builds/slave/test', 14:12:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:12:14 INFO - 'RUST_BACKTRACE': 'full', 14:12:14 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:12:14 INFO - 'SHELL': '/bin/bash', 14:12:14 INFO - 'SHLVL': '1', 14:12:14 INFO - 'TERM': 'linux', 14:12:14 INFO - 'TMOUT': '86400', 14:12:14 INFO - 'USER': 'cltbld', 14:12:14 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1504212552.181106-1619623144', 14:12:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:14 INFO - '_': '/tools/buildbot/bin/python'} 14:12:14 INFO - TEST-INFO | started process 22355 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJEQTqb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:12:14 INFO - PID 22355 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 14:12:15 INFO - PID 22355 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 14:12:15 INFO - PID 22355 | 14:12:15 INFO - PID 22355 | (/builds/slave/test/build/application/firefox/firefox:22417): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:12:15 INFO - PID 22355 | 14:12:25 INFO - PID 22355 | RSS: Main: 199778304 14:12:25 INFO - PID 22355 | 14:12:28 INFO - PID 22355 | Cycle 1(1): loaded http://localhost:57358/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57358/tests/kraken/driver.html?testName=audio-beat-detection) 14:12:29 INFO - PID 22355 | RSS: Main: 207073280 14:12:29 INFO - PID 22355 | 14:12:29 INFO - PID 22355 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 14:12:31 INFO - PID 22355 | Cycle 1(1): loaded http://localhost:57358/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57358/tests/kraken/driver.html?testName=audio-dft) 14:12:32 INFO - PID 22355 | RSS: Main: 211607552 14:12:32 INFO - PID 22355 | 14:12:35 INFO - PID 22355 | Cycle 1(1): loaded http://localhost:57358/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57358/tests/kraken/driver.html?testName=audio-fft) 14:12:36 INFO - PID 22355 | RSS: Main: 204812288 14:12:36 INFO - PID 22355 | 14:12:38 INFO - PID 22355 | Cycle 1(1): loaded http://localhost:57358/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57358/tests/kraken/driver.html?testName=audio-oscillator) 14:12:39 INFO - PID 22355 | RSS: Main: 205012992 14:12:39 INFO - PID 22355 | 14:12:41 INFO - PID 22355 | Cycle 1(1): loaded http://localhost:57358/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57358/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:12:41 INFO - PID 22355 | RSS: Main: 205340672 14:12:41 INFO - PID 22355 | 14:12:45 INFO - PID 22355 | Cycle 1(1): loaded http://localhost:57358/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57358/tests/kraken/driver.html?testName=imaging-darkroom) 14:12:45 INFO - PID 22355 | RSS: Main: 205070336 14:12:45 INFO - PID 22355 | 14:12:49 INFO - PID 22355 | Cycle 1(1): loaded http://localhost:57358/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57358/tests/kraken/driver.html?testName=imaging-desaturate) 14:12:49 INFO - PID 22355 | RSS: Main: 205754368 14:12:49 INFO - PID 22355 | 14:12:52 INFO - PID 22355 | Cycle 1(1): loaded http://localhost:57358/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57358/tests/kraken/driver.html?testName=json-parse-financial) 14:12:53 INFO - PID 22355 | RSS: Main: 207536128 14:12:53 INFO - PID 22355 | 14:12:54 INFO - PID 22355 | Cycle 1(1): loaded http://localhost:57358/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57358/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:12:55 INFO - PID 22355 | RSS: Main: 207503360 14:12:55 INFO - PID 22355 | 14:12:57 INFO - PID 22355 | Cycle 1(1): loaded http://localhost:57358/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57358/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:12:57 INFO - PID 22355 | RSS: Main: 206647296 14:12:57 INFO - PID 22355 | 14:13:00 INFO - PID 22355 | Cycle 1(1): loaded http://localhost:57358/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57358/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:13:00 INFO - PID 22355 | RSS: Main: 206778368 14:13:00 INFO - PID 22355 | 14:13:03 INFO - PID 22355 | Cycle 1(1): loaded http://localhost:57358/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57358/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:13:04 INFO - PID 22355 | RSS: Main: 206540800 14:13:04 INFO - PID 22355 | 14:13:07 INFO - PID 22355 | Cycle 1(1): loaded http://localhost:57358/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57358/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:13:07 INFO - PID 22355 | RSS: Main: 207503360 14:13:07 INFO - PID 22355 | 14:13:09 INFO - PID 22355 | Cycle 1(1): loaded http://localhost:57358/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57358/tests/kraken/driver.html?testName=ai-astar) 14:13:09 INFO - PID 22355 | RSS: Main: 209043456 14:13:09 INFO - PID 22355 | 14:13:09 INFO - PID 22355 | __start_tp_report 14:13:09 INFO - PID 22355 | _x_x_mozilla_page_load 14:13:09 INFO - PID 22355 | _x_x_mozilla_page_load_details 14:13:09 INFO - PID 22355 | |i|pagename|runs| 14:13:09 INFO - PID 22355 | |0;ai-astar;98;116;103;119;114;109;108;115;110;110 14:13:09 INFO - PID 22355 | |1;audio-beat-detection;161;125;154;192;116;143;155;122;177;123 14:13:09 INFO - PID 22355 | |2;audio-dft;173;162;164;165;165;170;164;165;163;163 14:13:09 INFO - PID 22355 | |3;audio-fft;84;76;76;175;77;76;75;73;160;77 14:13:09 INFO - PID 22355 | |4;audio-oscillator;79;78;125;81;78;84;131;81;90;126 14:13:09 INFO - PID 22355 | |5;imaging-gaussian-blur;121;115;114;113;115;122;121;118;115;115 14:13:09 INFO - PID 22355 | |6;imaging-darkroom;156;148;148;153;148;150;150;148;150;149 14:13:09 INFO - PID 22355 | |7;imaging-desaturate;103;94;95;95;97;96;95;97;94;102 14:13:09 INFO - PID 22355 | |8;json-parse-financial;53;52;57;53;61;53;54;52;54;57 14:13:09 INFO - PID 22355 | |9;json-stringify-tinderbox;47;38;41;42;40;37;38;46;38;38 14:13:09 INFO - PID 22355 | |10;stanford-crypto-aes;80;77;75;76;86;81;81;78;74;78 14:13:09 INFO - PID 22355 | |11;stanford-crypto-ccm;122;130;131;124;126;120;129;121;136;150 14:13:09 INFO - PID 22355 | |12;stanford-crypto-pbkdf2;177;174;172;173;176;172;171;169;172;178 14:13:09 INFO - PID 22355 | |13;stanford-crypto-sha256-iterative;74;67;66;72;68;66;65;66;70;64 14:13:09 INFO - PID 22355 | __end_tp_report 14:13:09 INFO - PID 22355 | __start_cc_report 14:13:09 INFO - PID 22355 | _x_x_mozilla_cycle_collect,924 14:13:09 INFO - PID 22355 | __end_cc_report 14:13:09 INFO - PID 22355 | __startTimestamp1504213989871__endTimestamp 14:13:09 INFO - PID 22355 | 14:13:09 INFO - PID 22355 | ------- Summary: start ------- 14:13:09 INFO - PID 22355 | Number of tests: 14 14:13:09 INFO - PID 22355 | 14:13:09 INFO - PID 22355 | [#0] ai-astar Cycles:10 Average:110.20 Median:114.50 stddev:6.29 (5.5%) stddev-sans-first:4.88 14:13:09 INFO - PID 22355 | Values: 98.0 116.0 103.0 119.0 114.0 109.0 108.0 115.0 110.0 110.0 14:13:09 INFO - PID 22355 | 14:13:09 INFO - PID 22355 | [#1] audio-beat-detection Cycles:10 Average:146.80 Median:154.50 stddev:25.59 (16.6%) stddev-sans-first:26.63 14:13:09 INFO - PID 22355 | Values: 161.0 125.0 154.0 192.0 116.0 143.0 155.0 122.0 177.0 123.0 14:13:09 INFO - PID 22355 | 14:13:09 INFO - PID 22355 | [#2] audio-dft Cycles:10 Average:165.40 Median:165.00 stddev:3.44 (2.1%) stddev-sans-first:2.30 14:13:09 INFO - PID 22355 | Values: 173.0 162.0 164.0 165.0 165.0 170.0 164.0 165.0 163.0 163.0 14:13:09 INFO - PID 22355 | 14:13:09 INFO - PID 22355 | [#3] audio-fft Cycles:10 Average:94.90 Median:76.00 stddev:38.53 (50.7%) stddev-sans-first:40.66 14:13:09 INFO - PID 22355 | Values: 84.0 76.0 76.0 175.0 77.0 76.0 75.0 73.0 160.0 77.0 14:13:09 INFO - PID 22355 | 14:13:09 INFO - PID 22355 | [#4] audio-oscillator Cycles:10 Average:95.30 Median:80.00 stddev:22.43 (28.0%) stddev-sans-first:23.00 14:13:09 INFO - PID 22355 | Values: 79.0 78.0 125.0 81.0 78.0 84.0 131.0 81.0 90.0 126.0 14:13:09 INFO - PID 22355 | 14:13:09 INFO - PID 22355 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:116.50 stddev:3.31 (2.8%) stddev-sans-first:3.17 14:13:09 INFO - PID 22355 | Values: 121.0 115.0 114.0 113.0 115.0 122.0 121.0 118.0 115.0 115.0 14:13:09 INFO - PID 22355 | 14:13:09 INFO - PID 22355 | [#6] imaging-darkroom Cycles:10 Average:150.00 Median:150.00 stddev:2.62 (1.7%) stddev-sans-first:1.66 14:13:09 INFO - PID 22355 | Values: 156.0 148.0 148.0 153.0 148.0 150.0 150.0 148.0 150.0 149.0 14:13:09 INFO - PID 22355 | 14:13:09 INFO - PID 22355 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:95.00 stddev:3.19 (3.4%) stddev-sans-first:2.47 14:13:09 INFO - PID 22355 | Values: 103.0 94.0 95.0 95.0 97.0 96.0 95.0 97.0 94.0 102.0 14:13:09 INFO - PID 22355 | 14:13:09 INFO - PID 22355 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:54.00 stddev:2.88 (5.3%) stddev-sans-first:2.99 14:13:09 INFO - PID 22355 | Values: 53.0 52.0 57.0 53.0 61.0 53.0 54.0 52.0 54.0 57.0 14:13:09 INFO - PID 22355 | 14:13:09 INFO - PID 22355 | [#9] json-stringify-tinderbox Cycles:10 Average:40.50 Median:40.50 stddev:3.54 (8.7%) stddev-sans-first:2.86 14:13:09 INFO - PID 22355 | Values: 47.0 38.0 41.0 42.0 40.0 37.0 38.0 46.0 38.0 38.0 14:13:09 INFO - PID 22355 | 14:13:09 INFO - PID 22355 | [#10] stanford-crypto-aes Cycles:10 Average:78.60 Median:79.00 stddev:3.53 (4.5%) stddev-sans-first:3.71 14:13:09 INFO - PID 22355 | Values: 80.0 77.0 75.0 76.0 86.0 81.0 81.0 78.0 74.0 78.0 14:13:09 INFO - PID 22355 | 14:13:09 INFO - PID 22355 | [#11] stanford-crypto-ccm Cycles:10 Average:128.90 Median:129.50 stddev:8.96 (6.9%) stddev-sans-first:9.15 14:13:09 INFO - PID 22355 | Values: 122.0 130.0 131.0 124.0 126.0 120.0 129.0 121.0 136.0 150.0 14:13:09 INFO - PID 22355 | 14:13:09 INFO - PID 22355 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.40 Median:173.50 stddev:2.84 (1.6%) stddev-sans-first:2.69 14:13:09 INFO - PID 22355 | Values: 177.0 174.0 172.0 173.0 176.0 172.0 171.0 169.0 172.0 178.0 14:13:09 INFO - PID 22355 | 14:13:09 INFO - PID 22355 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:67.50 stddev:3.22 (4.8%) stddev-sans-first:2.52 14:13:09 INFO - PID 22355 | Values: 74.0 67.0 66.0 72.0 68.0 66.0 65.0 66.0 70.0 64.0 14:13:09 INFO - PID 22355 | -------- Summary: end -------- 14:13:09 INFO - PID 22355 | 14:13:10 INFO - PID 22355 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 14:13:10 INFO - TEST-INFO | 22355: exit 0 14:13:10 INFO - TEST-OK | kraken | took 63445ms 14:13:10 INFO - SUITE-END | took 1179s 14:13:11 INFO - Completed test suite (00:19:39) 14:13:11 INFO - javascript benchmark 14:13:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8480.020313632713, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3241.011491495093, 3286.244163842318, 3299.1257316811048, 3302.4220761366755, 3337.8331083445823, 6196.876062478747, 6219.222597175353, 6222.066689996503, 6267.153934218879, 6299.401556852097, 6157.1995640566665, 6233.501319894409, 6246.750129994806, 6261.592996455227, 6268.404501572343, 5762.4525670061485, 5800.651960882361, 5840.094785308284, 5880.206172166745, 5924.348321684612, 5837.532997360201, 5857.3849745776715, 5928.851778705523, 5943.940560594404, 5950.196723442323, 5788.095826129908, 5792.68140252286, 5845.06478963368, 5868.970655146718, 5926.051831706928, 5654.886902261932, 5778.711064446761, 5788.450097240755, 5812.534997200214, 5850.853728656818, 5799.246098007275, 5830.3586605473365, 5865.853353666193, 5870.354261031283, 5870.530357571427, 6259.37406259375, 6279.717412716439, 6298.842528936768, 6348.746050157988, 6387.904181437236, 6556.803295901131, 6687.598744075371, 6694.364035416676, 6715.496337774637, 6779.084823548807, 6719.596824190564, 6722.966385168092, 6760.864782704319, 6781.966090169567, 6785.898211526782, 6219.782307619212, 6231.719572619198, 6294.779682711083, 6309.085182648536, 6320.241571011462, 6770.526063175629, 6869.003994420881, 6898.2756810535175, 6905.309469053054, 6935.6878940447805, 6605.438537724347, 6618.371254730793, 6627.403533681992, 6628.270890202074, 6643.302453242437, 6496.967515162489, 6618.933810661832, 6641.933580664131, 6703.966480167568, 6799.728010879509, 6637.1703537057865, 6691.26396096429, 6718.764843230561, 6731.932680673229, 6759.594424334556, 6715.93284067153, 6721.1598550181225, 6792.524523283323, 6808.148981377328, 6837.760678376233, 5194.22086687, 5264.42091369949, 5269.525742683177, 5273.446288139767, 5277.155655095166, 4509.639228861749, 4585.633149348044, 4627.838025669085, 4661.790219440133, 4678.415198100238, 5826.242588463558, 5844.853878653068, 5860.413958604106, 5860.882782344329, 5864.03243464832, 6720.865582688319, 6739.831504212336, 6790.456763458911, 6808.148981377328, 6817.079694241214, 5818.301803783488, 5819.039858423313, 5878.0, 5897.085951677411, 5910.143029260733, 5675.631083979528, 5726.226959360516, 5745.770169193185, 5815.651060936358, 5825.155352473867, 6516.934830651728, 6562.967185164043, 6609.735610575619, 6637.1703537057865, 6644.833879152963, 6810.8637827244165, 6851.794446166623, 6852.383285504129, 6875.828104297432, 6917.066196063668, 6584.50616203777, 6652.83367915806, 6667.833304167435, 6677.232118306457, 6712.932870671426, 6579.046038324512, 6668.533202675766, 6691.46468282546, 6751.966240168767, 6764.830879228059, 6683.231428385798, 6715.7985260442265, 6810.216825065181, 6818.147731533559, 6829.6243706596615, 6513.8697226056165, 6546.0508226307875, 6548.901766473602, 6598.076269322202, 6600.141981542561, 6542.640154791532, 6556.934430655632, 6559.672016399257, 6577.4409175218725, 6596.439302659328, 6500.447461965786, 6503.674816259263, 6513.1532900722605, 6539.869202616016, 6561.278259391368, 6470.6117632940295, 6619.437347825488, 6640.07039014548, 6692.498062645223, 6694.933050669431, 6268.905966410416, 6331.746730130927, 6354.555181137461, 6363.109164717036, 6378.107065010995], "value": 6157.68928005966, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [767.842592268585, 844.2444012608714, 866.3848667446115, 868.5613765048649, 1100.895414935581, 29023.419531609354, 30562.23594410138, 39954.60045399549, 40447.0, 40561.0, 40902.0, 41502.79248603753, 41631.0, 41700.0, 41708.58291417085, 7487.1764105948305, 7556.055493063367, 7594.620268986556, 7615.276548727889, 7621.314081732643, 5731.770729170828, 5869.530437564985, 7468.365188958918, 7516.624168791566, 7731.884021739678, 7641.6943322267325, 7766.650500727453, 7770.41721870862, 7773.494722843026, 7774.572398518079, 7654.693812247503, 7697.153313135578, 7724.961375193145, 7726.729564465217, 7727.034120734852, 7518.022657054548, 7535.095788505414, 7557.886631700474, 7577.052868391451, 7599.316061554431, 36549.0, 36799.264014719825, 36839.0, 36906.0, 36950.81524592387, 3452.430348992413, 3496.0385893879134, 3511.9297614047578, 3518.1908161123083, 3521.506989021539, 30526.847365763027, 30594.0, 30654.0, 30707.846460767778, 30722.38555228905, 4968.130577148984, 5154.690718556899, 5154.845354639367, 5159.509846564571, 5203.973980130113, 180283.0, 181736.0, 181891.0, 182408.08795956068, 182766.08616956964, 46753.766231169306, 46802.531974680496, 46818.5318146821, 46860.297095543596, 46874.0, 49200.50799492031, 50067.0, 51031.744841275555, 51414.22878656823, 51421.48578514242, 14989.775153372708, 15083.868709846805, 15134.470293539673, 15154.772678409832, 15163.620909477351, 12049.397530123459, 12281.385930703429, 12317.630471085882, 12328.50685972569, 12480.500779968881, 13698.794518082237, 13710.931445342909, 13739.656508587166, 13749.0, 13774.724505509834, 5409.0, 5525.4474552545225, 5545.417731138253, 5569.916451253234, 5616.66300022, 1008.8335424654997, 1017.6438246613774, 1025.2566889005561, 1035.8135535603665, 1039.443897514826, 23008.53982920332, 23060.769392306196, 23158.1894633687, 23295.650565241536, 23616.0, 1070.7644318249972, 1124.2860783402434, 1128.074978517624, 1128.6275529075385, 1130.2145009218514, 11775.0, 12064.155509114453, 12226.449809758582, 12248.326342051094, 15803.288852001688, 220256.0, 223318.0, 223812.0, 224011.0, 224111.0, 53346.73326633342, 53426.73286633542, 53919.73040134774, 54051.45948540543, 54288.185677214875, 1418.978715319271, 1433.4982756035304, 1445.3062529985666, 1460.4377314733692, 1466.9266536673338, 26755.464890702468, 27020.0, 27131.0, 27138.0, 27141.321466962694, 36713.0, 36870.0, 36896.81551592225, 36906.81546592357, 36940.0, 197468.0, 200193.0, 200585.0, 200619.0, 201581.0, 25700.8714956424, 28474.43051138924, 30743.0, 31710.68289317077, 31780.20549486189, 40178.59821401749, 40426.0, 40437.1912561753, 40602.39096413615, 40962.590374095875, 29571.704282957755, 29580.852095739385, 29796.0, 29942.401151976403, 30982.535261971538, 30141.36889884222, 30303.242418939702, 30396.93610723614, 30658.436213991663, 30825.383492330475, 33337.499937501445, 33418.331633367685, 33481.16297092592, 33522.16194595155, 36646.816765917065, 32419.513707293936, 32444.513332300507, 32546.511802323457, 33183.668163318056, 33500.83249583736, 23773.167939122046, 23952.40118997039, 24622.507549849262, 24655.753442465346, 24837.50324993454], "value": 16825.405980223437, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.1279236372167, 569.2542768972644, 569.2872029187106, 574.482965331202, 589.6138029590618, 21454.570908581838, 22347.10611575537, 22489.775102248972, 22523.54952900941, 22555.097796088157, 23564.64653030206, 25853.0, 25905.740942590568, 25954.610680839804, 26122.6081608776, 6616.106825578558, 6778.728850845961, 6796.830079248034, 6803.897941530881, 6804.965975170142, 6264.749410023594, 6631.568948018387, 6652.0, 6655.900161497581, 6680.832979175535, 6569.507286953473, 6593.340665933416, 6613.966930165342, 6618.238902526199, 6626.9668651656675, 6556.541042127053, 6602.8349291268105, 6617.205935287772, 6625.503087268474, 6626.966865165691, 6075.362086980847, 6089.939100608982, 6098.664573448458, 6125.0, 6138.84652883677, 25141.37146571332, 28863.855680721674, 29334.0, 29359.55960660592, 29392.0, 2055.989720051405, 2086.791320867916, 2087.217293514932, 2087.895605219748, 2091.1217288738612, 19548.609027819508, 19827.30604428838, 19858.801411985984, 19900.104495297746, 19922.402327930184, 2338.1933233034574, 2384.6542251373453, 2387.4270175158013, 2408.542376948392, 2437.890294936732, 134201.0, 134296.32851835777, 137528.31235843856, 137618.0, 138686.0, 13904.58286251414, 14520.927395362956, 14627.26863656813, 14632.195229262492, 15000.924995375171, 23235.883820580788, 23359.7664023361, 23390.415239618804, 23392.415189620395, 23420.18029368964, 9676.0, 9814.901850981541, 9820.803583928282, 9845.212383009342, 10050.040242152856, 8967.417117887317, 9061.54692265384, 9089.591113377437, 9121.45271283725, 9218.078192180863, 7601.277878601524, 9022.819543609223, 9111.407758495676, 9348.766280843034, 9376.0, 2631.5921032240035, 2640.5775075988136, 2668.6664166979126, 2756.8483733394455, 2791.3579876628487, 940.7083804020775, 959.1894848852709, 969.2488321550713, 990.6681261777385, 996.5366104761321, 18662.160202790634, 18874.245030198912, 19015.04924753757, 19241.711374329396, 19579.902100489406, 1002.9899701003043, 1038.8285932821, 1060.9787804244027, 1073.9946300268605, 1076.4402510694395, 10483.895161048444, 10892.346459212315, 11052.834207486894, 11111.555537778399, 11160.10719142483, 502371.0, 502619.0, 505697.0, 521643.0, 528627.0, 114326.42836785763, 119241.0, 122553.0, 123194.0, 123299.0, 1209.4859684633996, 1266.4997326056157, 1274.8597654258024, 1276.789329760579, 1277.0166971432132, 20890.268840591114, 20927.8953605231, 20953.26663566829, 21411.929403529448, 21490.892545537172, 56876.0, 57242.0, 57749.0, 58706.706466467396, 59552.70223648854, 71724.0, 72013.6399318, 72244.83265502044, 72487.0, 73133.634331828, 14152.646183845487, 14322.355494002586, 14340.784888226477, 14347.0, 14366.281685915872, 16622.833771662128, 22691.886540567193, 22906.0, 23147.07411703513, 23373.532529349657, 18087.728684070014, 18409.98745069034, 18446.35437759672, 18464.0, 18610.813891860907, 16901.0, 16908.66182676315, 17212.741808872626, 17505.474835754947, 17644.82355176432, 19728.0, 19965.700514492004, 19969.400917972485, 20024.299149529696, 20148.697769533177, 14578.927105364406, 14650.560483185522, 14838.629034274229, 14894.106353618818, 15019.32413041394, 18644.254229830654, 18820.52948676294, 18901.149448274584, 18997.62004759925, 19358.128884199963], "value": 12071.497706684097, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1298.22755460501, 1349.946002159913, 1363.1616555818175, 1368.1517459175313, 1374.285371606764, 14682.0, 15255.618609534768, 15289.770653440193, 15419.845801541982, 15426.69146617067, 15217.695646087072, 15630.687386252297, 15676.529704108867, 15691.293891774869, 15737.685246295066, 2780.791440641955, 2850.44416338814, 2855.200543847726, 2874.2095923620964, 2876.697946715596, 2608.0, 2704.0, 2768.3632764464187, 2801.271669365959, 2802.4395120975782, 2809.9157025289273, 2822.6895041545413, 2828.2363761784304, 2852.5578535326954, 2859.5567687008547, 2556.118139241968, 2585.870706464669, 2591.067215802319, 2595.2084614192663, 2703.1214855172047, 2634.907778227772, 2680.289723223347, 2684.8254863433813, 2687.3953360493733, 2692.851893145876, 14849.183294918776, 15063.698726025417, 15167.165805880672, 15283.235838208046, 15309.234538273153, 7766.922330776676, 8032.236937490929, 8046.637901294456, 8049.3962952778775, 8061.677532898677, 5063.772130254148, 5083.3391659084455, 5362.088444964365, 5368.946310536923, 5431.4840090191365, 1777.2624360890215, 1786.5265704588294, 1815.9636807263912, 1842.7051671732593, 1852.8425083867887, 26519.73480265192, 27008.594871076948, 27011.594826077624, 27021.324466888287, 27108.45783084347, 6949.687264073129, 6965.582065076112, 6985.196702379189, 7072.0, 7112.14654241484, 17095.743563846554, 17106.828931710774, 17156.571085722957, 17182.65634687299, 17210.0, 7568.318851303409, 7682.423818213656, 7731.0336207974005, 7743.651535680908, 7757.495762775401, 7014.263502332284, 7147.1780745214965, 7271.709131634781, 7460.0674915635545, 7494.325510704063, 5228.346456692913, 5409.269748583891, 5442.782288708408, 5451.672899626035, 5466.644668096561, 1347.2253454263837, 1366.9453221871213, 1539.5612250508552, 1563.523125446727, 1590.864776494011, 917.3211823250747, 934.8784657994553, 947.5309721687809, 948.2177203806887, 948.6964171465203, 8505.192006759347, 8701.17338852808, 8715.389922705477, 8764.8685269721, 8796.736097917073, 981.1415011864618, 1010.3634710132569, 1011.2870426349406, 1014.8274793285011, 1019.3068713274896, 5219.781587845397, 5398.13629819227, 5462.890742185214, 5492.395836457987, 5725.456081672234, 21018.369448916557, 21898.0, 22096.2266320678, 22184.667229991563, 22330.441738956655, 20184.394468165978, 21343.573128537344, 21529.569408612053, 21586.78413215879, 21697.24059657936, 10822.67531974042, 11340.376279304717, 11345.205835591429, 11354.48904799286, 11449.54201831934, 8044.034715834137, 8414.87377689323, 8419.494830310201, 8426.536540490331, 8588.699395521377, 18690.532736681693, 18859.339923102627, 18996.620067598848, 19260.0, 19424.708629370853, 18784.90607547008, 19172.808271917103, 19322.516937076685, 19429.319973800848, 20320.0, 11961.461734221806, 12049.277043377426, 12073.75852482963, 12135.393230338625, 12141.878581214074, 14057.367418466398, 14140.646483837987, 14219.786703199254, 14241.928790355982, 14370.0, 11424.82862757076, 11547.653570392566, 11552.826707599224, 11569.710757231136, 11784.057275417774, 10972.177086718688, 11249.156313276373, 11251.437428128724, 11282.887171128184, 11374.772504549697, 9568.808623827344, 9590.232781377612, 9766.267529935141, 9800.11798938099, 9801.0, 7028.894566581607, 7153.3919616833155, 7177.856442871009, 7234.276572342724, 7337.59643219628, 6781.0845535854005, 6824.112865327475, 6909.205441374306, 6917.169939607078, 7015.929840701528], "value": 6731.7649540258835, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.5189292332898, 503.35067762586266, 527.3724268120933, 538.2357052984761, 541.8239072301501, 6265.216847894013, 6266.086269884503, 6310.305866354709, 6362.236531616201, 6365.522585806066, 5964.970175149118, 6131.8773624527485, 6156.507479401648, 6206.472449841757, 6263.812085637438, 4956.876078098058, 4975.850724478271, 5003.849884503471, 5029.0, 5075.0, 4905.681130726492, 4968.403791545002, 4975.353204083464, 5018.64869459138, 5040.790210349508, 4866.0, 4955.679694604605, 4970.0, 4984.252362145689, 5016.770891131678, 4976.079425306312, 4991.700497970133, 5021.648484606098, 5036.445990940993, 5043.646944713872, 4440.822367105312, 4473.127740090684, 4485.775711214426, 4492.483364413101, 4510.436195475566, 6054.182685337511, 6078.422549857756, 6081.817545473598, 6102.169349195224, 6133.1413602095745, 5650.915236271459, 5656.151577263443, 5727.570432217601, 5738.368779434259, 5760.308762948473, 6575.342465753434, 6579.868402631969, 6587.538872278942, 6614.0, 6634.469242460592, 4829.1548978928895, 4842.685225460369, 4886.364772579577, 4886.877828054327, 4889.902201955976, 6815.0, 6885.380315771605, 6905.37851593354, 6938.41023513002, 6962.2341542430295, 4972.204447288416, 4998.400191976986, 5028.296038554606, 5031.396232452129, 5043.3191519145175, 5084.576418515915, 5110.872228194251, 5121.411037730634, 5123.7438128093445, 5135.12702840518, 5603.7758489659955, 5692.206954809222, 5701.144828275792, 5732.426757324234, 5734.426557344233, 6486.2216534016225, 6497.512686548528, 6512.283648798629, 6554.7378104876225, 6587.703553340111, 1721.0, 1731.212298404223, 1756.1482680899753, 1760.4718584424622, 1769.2392271323197, 1120.8767035626074, 1149.8850114988434, 1159.3739380734478, 1198.964031079069, 1243.1670780577035, 5653.830385088454, 5690.260266165372, 5695.0, 5701.942980570141, 5727.0, 6319.273283572356, 6496.935030649633, 6555.901661475082, 6605.76879809214, 6659.733610655519, 5625.521830644359, 5636.661800291996, 5668.57485688575, 5691.9146212806845, 5694.430556944355, 3480.164760457472, 3524.242287908112, 3555.7333200010103, 3563.2517171394297, 3582.229820588586, 6421.646809425526, 6472.013387616436, 6473.935260647333, 6504.609723416515, 6505.0, 6732.0, 6808.659567021629, 6901.896471552931, 6942.51402401827, 6981.89527157093, 6441.967790161019, 6500.772472963518, 6532.98221593726, 6576.309487503743, 6601.636909969998, 6629.2376376715365, 6632.801015969529, 6709.832254193684, 6723.495737819585, 6778.389944904785, 6580.782555227298, 6625.834354141185, 6635.601863888182, 6669.233038200669, 6703.430208432338, 6482.157319548429, 6518.706658200297, 6520.445762110274, 6601.636909969998, 6641.900371494528, 4967.453580106113, 4981.701097934136, 4989.351384320015, 5049.2426136079885, 5063.3417655704525, 6633.867322653617, 6671.532992690465, 6792.4792199487065, 6806.18325800907, 6831.9658401707675, 6480.44916182111, 6560.950247960303, 6562.77030303937, 6565.310642382672, 6566.474682025522, 6460.86647975722, 6501.707423165874, 6519.315471875385, 6549.869002619826, 6630.90053649186, 6337.873242535031, 6397.712102955285, 6400.871982560416, 6432.807015789534, 6532.510061745293, 6208.286047104641, 6529.51028672861, 6602.66986650656, 6706.138049913773, 6719.664016799238, 6239.500839932885, 6331.145295385064, 6372.458341040878, 6389.2971773105855, 6448.387403196689], "value": 5049.459924354697, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [896.7040876510752, 896.896856861461, 917.7889085510333, 922.9446233226003, 924.1497822003756, 15527.146006969611, 16272.837271627295, 16302.184890755474, 19779.703304450446, 20772.272970446036, 20224.8988755056, 20407.795922040776, 21182.89408552955, 21400.35798926031, 21506.60207086542, 958.5686441101515, 981.68095369005, 989.7228775942748, 990.6631745206628, 997.3367710472563, 950.6530116507494, 1009.3741880034353, 1012.2003617142449, 1012.4785735346265, 1014.031599822168, 1045.2474218562622, 1063.3301020357203, 1064.7817197474537, 1066.4347895615335, 1068.5405275731432, 1052.8526006359077, 1059.369675043352, 1062.1874266186373, 1062.7449412141107, 1066.2696053203542, 770.96916123355, 773.6673230510878, 773.8258891749367, 774.7017398301638, 775.97672069838, 18612.0, 19113.904430477898, 19161.13774880134, 19273.518162045923, 19537.609247815108, 20277.594448110955, 20801.58396832055, 20852.895735521226, 20868.582628347347, 20880.164793408247, 16608.584785380463, 16999.830001700073, 17006.659866802718, 17029.914850425794, 17032.296770322868, 3625.8187090645624, 3683.797391143486, 3686.705063594906, 3690.4833323334756, 3692.46459263408, 125482.0, 128782.0, 129191.35404323012, 130707.0, 130745.0, 15562.0, 15674.373025079098, 15853.920730396274, 15977.840221597635, 16064.0, 27577.17268481949, 28655.283617909718, 29036.7096329034, 29045.709542904722, 29760.702392976225, 7946.801329966682, 7956.721514746956, 7962.163972782774, 7984.560849153352, 8040.557769322626, 3966.643002129764, 4072.470578824793, 4103.794810259535, 4111.301078816608, 4115.238680844053, 5162.6902385856965, 5261.289725886956, 5380.0, 5381.67709937405, 5389.0, 926.666400095965, 951.3816019587185, 958.2525630008604, 966.8888077871135, 967.6129548180784, 536.4796147736768, 633.7084940927133, 656.2059907511868, 658.805652332563, 674.0798809624827, 11037.558497660164, 11309.321440713584, 11493.655190344303, 11868.347240901661, 12131.636050918487, 627.6547898655813, 635.7488791927162, 637.6907200007993, 642.6722371590522, 648.4779752299349, 5424.783008679608, 5434.456554344534, 5662.462066103713, 5701.144828275792, 5723.713814309268, 98664.0, 105728.47135764272, 105886.47056764667, 111150.44424777986, 111873.0, 95178.0, 95804.52097739467, 96864.0, 97367.51316243374, 97575.0, 81656.59171704222, 81771.0, 84516.57741711252, 85062.5746871274, 86877.62051241155, 9483.099105584959, 9550.95224523873, 9591.520423978913, 9777.364471309342, 9806.607735690777, 38453.0, 39206.21587568176, 39310.0344982744, 39870.80064599658, 40177.0, 51812.0, 51990.220146698586, 53213.0, 53321.46678533165, 53406.0, 14728.852711472748, 14802.407903683732, 14932.7760083601, 16023.759643605588, 16578.58553536171, 19133.712994304817, 19493.61012779765, 19502.8049719501, 19558.511037224183, 19662.90168549148, 17285.0, 17735.556611084827, 18058.729119062962, 18121.637567248847, 18149.183286751864, 16746.916265418597, 17055.914720426317, 17521.56196095108, 17853.821461785217, 17910.820891790914, 15889.841101588836, 16329.101899395648, 16531.504054878373, 16654.750178747086, 16752.162391880112, 11761.647150585497, 11793.115516336138, 12282.38588070575, 12285.078619103424, 12728.427220774902, 13278.0, 13632.591022269347, 13701.0, 13721.970852185927, 13731.313434328444], "value": 8746.570470130444, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1520.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 116.0, 103.0, 119.0, 114.0, 109.0, 108.0, 115.0, 110.0, 110.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 125.0, 154.0, 192.0, 116.0, 143.0, 155.0, 122.0, 177.0, 123.0], "value": 146.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 162.0, 164.0, 165.0, 165.0, 170.0, 164.0, 165.0, 163.0, 163.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 76.0, 76.0, 175.0, 77.0, 76.0, 75.0, 73.0, 160.0, 77.0], "value": 94.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 125.0, 81.0, 78.0, 84.0, 131.0, 81.0, 90.0, 126.0], "value": 95.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 115.0, 114.0, 113.0, 115.0, 122.0, 121.0, 118.0, 115.0, 115.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 148.0, 148.0, 153.0, 148.0, 150.0, 150.0, 148.0, 150.0, 149.0], "value": 150.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 94.0, 95.0, 95.0, 97.0, 96.0, 95.0, 97.0, 94.0, 102.0], "value": 96.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 57.0, 53.0, 61.0, 53.0, 54.0, 52.0, 54.0, 57.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 38.0, 41.0, 42.0, 40.0, 37.0, 38.0, 46.0, 38.0, 38.0], "value": 40.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 77.0, 75.0, 76.0, 86.0, 81.0, 81.0, 78.0, 74.0, 78.0], "value": 78.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 130.0, 131.0, 124.0, 126.0, 120.0, 129.0, 121.0, 136.0, 150.0], "value": 128.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 174.0, 172.0, 173.0, 176.0, 172.0, 171.0, 169.0, 172.0, 178.0], "value": 173.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 67.0, 66.0, 72.0, 68.0, 66.0, 65.0, 66.0, 70.0, 64.0], "value": 67.8, "unit": "score"}]}]} 14:13:11 INFO - Return code: 0 14:13:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:13:11 INFO - # TBPL SUCCESS # 14:13:11 INFO - Running post-action listener: _package_coverage_data 14:13:11 INFO - Running post-action listener: _resource_record_post_action 14:13:11 INFO - [mozharness: 2017-08-31 21:13:11.163656Z] Finished run-tests step (success) 14:13:11 INFO - Running post-run listener: _resource_record_post_run 14:13:11 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 3526656; Write bytes: 389140480; Read time: 4344; Write time: 292588 14:13:11 INFO - TinderboxPrint: CPU usage
13.3% 14:13:11 INFO - TinderboxPrint: I/O read bytes / time
3,526,656 / 4,344 14:13:11 INFO - TinderboxPrint: I/O write bytes / time
389,140,480 / 292,588 14:13:11 INFO - TinderboxPrint: CPU idle
8,273.3 (86.7%) 14:13:11 INFO - TinderboxPrint: CPU user
1,202.6 (12.6%) 14:13:11 INFO - TinderboxPrint: Swap in / out
0 / 0 14:13:11 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 106037248; Read time: 0; Write time: 109912 14:13:11 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 14:13:11 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 3526656; Write bytes: 282595328; Read time: 4344; Write time: 182648 14:13:11 INFO - Running post-run listener: _upload_blobber_files 14:13:11 INFO - Blob upload gear active. 14:13:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:13:11 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 14:13:11 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'] 14:13:11 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 14:13:12 INFO - (blobuploader) - INFO - Open directory for files ... 14:13:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:13:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:13:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:13:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:13:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:13:13 INFO - (blobuploader) - INFO - Done attempting. 14:13:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:13:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:13:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:13:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:13:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:13:16 INFO - (blobuploader) - INFO - Done attempting. 14:13:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:13:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:13:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:13:17 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:13:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:13:17 INFO - (blobuploader) - INFO - Done attempting. 14:13:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:13:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:13:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:13:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:13:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:13:18 INFO - (blobuploader) - INFO - Done attempting. 14:13:18 INFO - (blobuploader) - INFO - Iteration through files over. 14:13:18 INFO - Return code: 0 14:13:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:13:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:13:18 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e48e70fb2fc65abc405d872f71e1d0df787024e1390194efb96d710e68fa48a12f049f6c175cde704686b254b9846ac8c452e1bd2564a2f61892dc4b19325bbe", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f049a9db23a0919718ff94798924119addcf443cbf07af0a33c32cf8c1f236b970ba6ffcc5cfbe956ba7640438952eed66a95846bd6c2aae9d7d4fb8ab4853ae", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4da8ce3171b2aa1eea75897231e313338898e9cd3ac9bd0399c8a6d74577256d5c9b0acd08052927aeb71b6940eb8589612c1ab9ddece80ddc0f8f2b8776994c", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5eb17c9f5d98f2018a0c927f92bceb7fd8fb72492789c508a70ce0ae3e04d15d688ae8660947fe775830a0d2ff0473b14cb06263142e2111d50995afa8f73a3c"} 14:13:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:13:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:13:18 INFO - Contents: 14:13:18 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e48e70fb2fc65abc405d872f71e1d0df787024e1390194efb96d710e68fa48a12f049f6c175cde704686b254b9846ac8c452e1bd2564a2f61892dc4b19325bbe", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f049a9db23a0919718ff94798924119addcf443cbf07af0a33c32cf8c1f236b970ba6ffcc5cfbe956ba7640438952eed66a95846bd6c2aae9d7d4fb8ab4853ae", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4da8ce3171b2aa1eea75897231e313338898e9cd3ac9bd0399c8a6d74577256d5c9b0acd08052927aeb71b6940eb8589612c1ab9ddece80ddc0f8f2b8776994c", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5eb17c9f5d98f2018a0c927f92bceb7fd8fb72492789c508a70ce0ae3e04d15d688ae8660947fe775830a0d2ff0473b14cb06263142e2111d50995afa8f73a3c"} 14:13:18 INFO - Running post-run listener: copy_logs_to_upload_dir 14:13:18 INFO - Copying logs to upload dir... 14:13:18 INFO - mkdir: /builds/slave/test/build/upload/logs 14:13:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.491369 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-31 14:13:18.460021) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-31 14:13:18.463893) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ea65d483da93c827905c2090000001f5-1504212552.181106-1619623144 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e48e70fb2fc65abc405d872f71e1d0df787024e1390194efb96d710e68fa48a12f049f6c175cde704686b254b9846ac8c452e1bd2564a2f61892dc4b19325bbe", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f049a9db23a0919718ff94798924119addcf443cbf07af0a33c32cf8c1f236b970ba6ffcc5cfbe956ba7640438952eed66a95846bd6c2aae9d7d4fb8ab4853ae", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4da8ce3171b2aa1eea75897231e313338898e9cd3ac9bd0399c8a6d74577256d5c9b0acd08052927aeb71b6940eb8589612c1ab9ddece80ddc0f8f2b8776994c", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5eb17c9f5d98f2018a0c927f92bceb7fd8fb72492789c508a70ce0ae3e04d15d688ae8660947fe775830a0d2ff0473b14cb06263142e2111d50995afa8f73a3c"} build_url:https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011422 build_url: 'https://queue.taskcluster.net/v1/task/ZFWS62EnTCq2ZhmByr1xKg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e48e70fb2fc65abc405d872f71e1d0df787024e1390194efb96d710e68fa48a12f049f6c175cde704686b254b9846ac8c452e1bd2564a2f61892dc4b19325bbe", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f049a9db23a0919718ff94798924119addcf443cbf07af0a33c32cf8c1f236b970ba6ffcc5cfbe956ba7640438952eed66a95846bd6c2aae9d7d4fb8ab4853ae", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4da8ce3171b2aa1eea75897231e313338898e9cd3ac9bd0399c8a6d74577256d5c9b0acd08052927aeb71b6940eb8589612c1ab9ddece80ddc0f8f2b8776994c", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5eb17c9f5d98f2018a0c927f92bceb7fd8fb72492789c508a70ce0ae3e04d15d688ae8660947fe775830a0d2ff0473b14cb06263142e2111d50995afa8f73a3c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-31 14:13:18.491342) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 14:13:18.491722) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ea65d483da93c827905c2090000001f5-1504212552.181106-1619623144 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004553 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 14:13:18.579888) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-31 14:13:18.580255) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-31 14:13:18.580623) ========= ========= Total master_lag: 0.25 =========