builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-024 starttime: 1503013086.25 results: success (0) revision: 2fb6d8f7bac1be26b2b49b68fc34cc6decd7f339 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-17 16:38:06.245320) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-17 16:38:06.245752) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-17 16:38:06.246033) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-17 16:38:06.261577) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 16:38:06.261842) ========= 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=41a7e32711b8e08598a63237000001d6-1503013085.451569-1706368872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-17 16:38:06-- 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% 100M=0s 2017-08-17 16:38:06 (100 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.145828 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 16:38:06.426795) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 16:38:06.427248) ========= 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=41a7e32711b8e08598a63237000001d6-1503013085.451569-1706368872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017146 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 16:38:06.479731) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 16:38:06.480021) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2fb6d8f7bac1be26b2b49b68fc34cc6decd7f339 --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 2fb6d8f7bac1be26b2b49b68fc34cc6decd7f339 --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=41a7e32711b8e08598a63237000001d6-1503013085.451569-1706368872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-17 16:38:06,599 truncating revision to first 12 chars 2017-08-17 16:38:06,599 Setting DEBUG logging. 2017-08-17 16:38:06,599 attempt 1/10 2017-08-17 16:38:06,599 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2fb6d8f7bac1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-17 16:38:07,067 unpacking tar archive at: mozilla-central-2fb6d8f7bac1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.779089 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 16:38:07.279574) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-17 16:38:07.279889) ========= script_repo_revision: 2fb6d8f7bac1be26b2b49b68fc34cc6decd7f339 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-17 16:38:07.280261) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-17 16:38:07.280518) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-17 16:38:07.291381) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-08-17 16:38:07.291641) ========= /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=41a7e32711b8e08598a63237000001d6-1503013085.451569-1706368872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:38:07 INFO - MultiFileLogger online at 20170817 16:38:07 in /builds/slave/test 16:38:07 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 16:38:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:38:07 INFO - {'append_to_log': False, 16:38:07 INFO - 'base_work_dir': '/builds/slave/test', 16:38:07 INFO - 'blob_upload_branch': 'Firefox', 16:38:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:38:07 INFO - 'branch': 'Firefox', 16:38:07 INFO - 'buildbot_json_path': 'buildprops.json', 16:38:07 INFO - 'code_coverage': False, 16:38:07 INFO - 'config_files': ('talos/linux_config.py',), 16:38:07 INFO - 'default_actions': ('clobber', 16:38:07 INFO - 'read-buildbot-config', 16:38:07 INFO - 'download-and-extract', 16:38:07 INFO - 'populate-webroot', 16:38:07 INFO - 'create-virtualenv', 16:38:07 INFO - 'install', 16:38:07 INFO - 'setup-mitmproxy', 16:38:07 INFO - 'run-tests'), 16:38:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:38:07 INFO - 'disable_ccov_upload': False, 16:38:07 INFO - 'download_minidump_stackwalk': True, 16:38:07 INFO - 'download_symbols': 'ondemand', 16:38:07 INFO - 'enable_stylo': False, 16:38:07 INFO - 'enable_webrender': False, 16:38:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:38:07 INFO - 'tooltool.py': '/tools/tooltool.py', 16:38:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:38:07 INFO - '/tools/misc-python/virtualenv.py')}, 16:38:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:38:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:38:07 INFO - 'gecko_profile': False, 16:38:07 INFO - 'gecko_profile_interval': 0, 16:38:07 INFO - 'installer_path': 'installer.exe', 16:38:07 INFO - 'log_level': 'info', 16:38:07 INFO - 'log_name': 'talos', 16:38:07 INFO - 'log_to_console': True, 16:38:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:38:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:38:07 INFO - 'opt_config_files': (), 16:38:07 INFO - 'pip_index': False, 16:38:07 INFO - 'suite': 'dromaeojs-e10s', 16:38:07 INFO - 'system_bits': '32', 16:38:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:38:07 INFO - 'title': 'talos-linux64-ix-024', 16:38:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:38:07 INFO - 'use_talos_json': True, 16:38:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:38:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:38:07 INFO - 'work_dir': 'build'} 16:38:07 INFO - [mozharness: 2017-08-17 23:38:07.509753Z] Running clobber step. 16:38:07 INFO - Running pre-action listener: _resource_record_pre_action 16:38:07 INFO - Running main action method: clobber 16:38:07 INFO - rmtree: /builds/slave/test/build 16:38:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:38:09 INFO - Running post-action listener: _resource_record_post_action 16:38:09 INFO - [mozharness: 2017-08-17 23:38:09.156901Z] Finished clobber step (success) 16:38:09 INFO - [mozharness: 2017-08-17 23:38:09.157004Z] Running read-buildbot-config step. 16:38:09 INFO - Running pre-action listener: _resource_record_pre_action 16:38:09 INFO - Running main action method: read_buildbot_config 16:38:09 INFO - Using buildbot properties: 16:38:09 INFO - { 16:38:09 INFO - "project": "", 16:38:09 INFO - "product": "firefox", 16:38:09 INFO - "who": "kwierso@gmail.com", 16:38:09 INFO - "installer_path": "public/build/target.tar.bz2", 16:38:09 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 16:38:09 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:38:09 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 16:38:09 INFO - "stage_platform": "linux64-stylo", 16:38:09 INFO - "basedir": "/builds/slave/test", 16:38:09 INFO - "buildnumber": 40, 16:38:09 INFO - "platform": "ubuntu64_hw_stylo", 16:38:09 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:38:09 INFO - "slavebuilddir": "test", 16:38:09 INFO - "taskId": "bHp0svW6SjCX-pLub2UoRA", 16:38:09 INFO - "branch": "mozilla-central", 16:38:09 INFO - "script_repo_revision": "production", 16:38:09 INFO - "revision": "2fb6d8f7bac1be26b2b49b68fc34cc6decd7f339", 16:38:09 INFO - "slavename": "talos-linux64-ix-024", 16:38:09 INFO - "repo_path": "mozilla-central" 16:38:09 INFO - } 16:38:09 INFO - Finding installer, test and symbols from parent task. 16:38:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bHp0svW6SjCX-pLub2UoRA'}, attempt #1 16:38:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bHp0svW6SjCX-pLub2UoRA'}, attempt #1 16:38:10 INFO - Task dependencies: Fda-eMH8RpC4QtyvHDqLcA 16:38:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA'}, attempt #1 16:38:10 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.tar.bz2 16:38:10 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.test_packages.json 16:38:10 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.crashreporter-symbols.zip 16:38:10 INFO - Running post-action listener: _resource_record_post_action 16:38:10 INFO - [mozharness: 2017-08-17 23:38:10.512307Z] Finished read-buildbot-config step (success) 16:38:10 INFO - [mozharness: 2017-08-17 23:38:10.512528Z] Running download-and-extract step. 16:38:10 INFO - Running pre-action listener: _resource_record_pre_action 16:38:10 INFO - Running main action method: download_and_extract 16:38:10 INFO - mkdir: /builds/slave/test/build/tests 16:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:38:10 INFO - trying https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.test_packages.json 16:38:10 INFO - Downloading https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:38:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:38:11 INFO - Downloaded 989 bytes. 16:38:11 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:38:11 INFO - Using the following test package requirements: 16:38:11 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:38:11 INFO - u'common': [u'target.common.tests.zip'], 16:38:11 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:38:11 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:38:11 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:38:11 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:38:11 INFO - u'mozbase': [u'target.common.tests.zip'], 16:38:11 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:38:11 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:38:11 INFO - u'web-platform': [u'target.common.tests.zip', 16:38:11 INFO - u'target.web-platform.tests.tar.gz'], 16:38:11 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:38:11 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:38:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.common.tests.zip 16:38:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:38:11 INFO - Fetch https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.common.tests.zip into memory 16:38:13 INFO - Content-Length response header: 54000841 16:38:13 INFO - Bytes received: 54000841 16:38:23 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:38:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.common.tests.zip 16:38:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:38:23 INFO - Fetch https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.common.tests.zip into memory 16:38:24 INFO - Content-Length response header: 54000841 16:38:24 INFO - Bytes received: 54000841 16:38:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.talos.tests.zip 16:38:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:38:36 INFO - Fetch https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.talos.tests.zip into memory 16:38:37 INFO - Content-Length response header: 14496161 16:38:37 INFO - Bytes received: 14496161 16:38:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:38:37 INFO - trying https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.tar.bz2 16:38:37 INFO - Downloading https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:38:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:38:39 INFO - Downloaded 62296625 bytes. 16:38:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.tar.bz2 16:38:39 INFO - mkdir: /builds/slave/test/properties 16:38:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:38:39 INFO - Writing to file /builds/slave/test/properties/build_url 16:38:39 INFO - Contents: 16:38:39 INFO - build_url:https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.tar.bz2 16:38:39 INFO - Running post-action listener: _resource_record_post_action 16:38:39 INFO - Running post-action listener: set_extra_try_arguments 16:38:39 INFO - [mozharness: 2017-08-17 23:38:39.010758Z] Finished download-and-extract step (success) 16:38:39 INFO - [mozharness: 2017-08-17 23:38:39.010856Z] Running populate-webroot step. 16:38:39 INFO - Running pre-action listener: _resource_record_pre_action 16:38:39 INFO - Running main action method: populate_webroot 16:38:39 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:38:39 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 16:38:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:38:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:38:39 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 16:38:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:38:39 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:38:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:38:39 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:38:39 INFO - 'talos_options': ['--stylo'], 16:38:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:38:39 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:38:39 INFO - 'tests': ['damp', 'tps']}, 16:38:39 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:38:39 INFO - 'talos_options': ['--stylo'], 16:38:39 INFO - 'tests': ['damp', 'tps']}, 16:38:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:38:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:38:39 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 16:38:39 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 16:38:39 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:38:39 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:38:39 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:38:39 INFO - 'talos_options': ['--stylo'], 16:38:39 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:38:39 INFO - 'other-e10s': {'tests': ['a11yr', 16:38:39 INFO - 'ts_paint', 16:38:39 INFO - 'tpaint', 16:38:39 INFO - 'sessionrestore', 16:38:39 INFO - 'sessionrestore_many_windows', 16:38:39 INFO - 'sessionrestore_no_auto_restore', 16:38:39 INFO - 'tabpaint']}, 16:38:39 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 16:38:39 INFO - 'tests': ['a11yr', 16:38:39 INFO - 'ts_paint', 16:38:39 INFO - 'tpaint', 16:38:39 INFO - 'sessionrestore', 16:38:39 INFO - 'sessionrestore_many_windows', 16:38:39 INFO - 'sessionrestore_no_auto_restore', 16:38:39 INFO - 'tabpaint']}, 16:38:39 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 16:38:39 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 16:38:39 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 16:38:39 INFO - 'tests': ['bloom_basic_singleton']}, 16:38:39 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 16:38:39 INFO - 'tests': ['bloom_basic']}, 16:38:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:38:39 INFO - 'tsvgr_opacity', 16:38:39 INFO - 'tart', 16:38:39 INFO - 'tscrollx', 16:38:39 INFO - 'tsvg_static']}, 16:38:39 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 16:38:39 INFO - 'tests': ['tsvgx', 16:38:39 INFO - 'tsvgr_opacity', 16:38:39 INFO - 'tart', 16:38:39 INFO - 'tscrollx', 16:38:39 INFO - 'tsvg_static']}, 16:38:39 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:38:39 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:38:39 INFO - 'talos_options': ['--stylo'], 16:38:39 INFO - 'tests': ['tp5o']}, 16:38:39 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:38:39 INFO - 'talos_options': ['--mitmproxy', 16:38:39 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:38:39 INFO - '--firstNonBlankPaint'], 16:38:39 INFO - 'tests': ['tp6_google', 16:38:39 INFO - 'tp6_youtube', 16:38:39 INFO - 'tp6_amazon', 16:38:39 INFO - 'tp6_facebook']}, 16:38:39 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:38:39 INFO - 'talos_options': ['--stylo', 16:38:39 INFO - '--mitmproxy', 16:38:39 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:38:39 INFO - '--firstNonBlankPaint'], 16:38:39 INFO - 'tests': ['tp6_google', 16:38:39 INFO - 'tp6_youtube', 16:38:39 INFO - 'tp6_amazon', 16:38:39 INFO - 'tp6_facebook']}, 16:38:39 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:38:39 INFO - 'talos_options': ['--stylo', 16:38:39 INFO - '--stylo-threads=1', 16:38:39 INFO - '--mitmproxy', 16:38:39 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:38:39 INFO - '--firstNonBlankPaint'], 16:38:39 INFO - 'tests': ['tp6_google', 16:38:39 INFO - 'tp6_youtube', 16:38:39 INFO - 'tp6_amazon', 16:38:39 INFO - 'tp6_facebook']}, 16:38:39 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:38:39 INFO - 'talos_options': ['--xperf_path', 16:38:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:38:39 INFO - 'tests': ['tp5n']}, 16:38:39 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:38:39 INFO - 'talos_options': ['--stylo', 16:38:39 INFO - '--xperf_path', 16:38:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:38:39 INFO - 'tests': ['tp5n']}}} 16:38:39 INFO - Running post-action listener: _resource_record_post_action 16:38:39 INFO - [mozharness: 2017-08-17 23:38:39.025230Z] Finished populate-webroot step (success) 16:38:39 INFO - [mozharness: 2017-08-17 23:38:39.025321Z] Running create-virtualenv step. 16:38:39 INFO - Running pre-action listener: _resource_record_pre_action 16:38:39 INFO - Running main action method: create_virtualenv 16:38:39 INFO - Creating virtualenv /builds/slave/test/build/venv 16:38:39 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:38:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:38:39 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:38:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:38:39 INFO - Using real prefix '/usr' 16:38:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:38:39 INFO - Installing distribute.............................................................................................................................................................................................done. 16:38:41 INFO - Installing pip.................done. 16:38:41 INFO - Return code: 0 16:38:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:38:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:38:41 INFO - Reading from file tmpfile_stdout 16:38:41 INFO - Output received: 16:38:41 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 16:38:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:38:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:38:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:38:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:41 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 0xb701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc74a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe17c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe14cc0>, '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 0xe15cd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe16160>, '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': '41a7e32711b8e08598a63237000001d6-1503013085.451569-1706368872', '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 16:38:41 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 16:38:41 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 16:38:41 INFO - Using env: {'DISPLAY': ':0', 16:38:41 INFO - 'HOME': '/home/cltbld', 16:38:41 INFO - 'LANG': 'en_US.UTF-8', 16:38:41 INFO - 'LANGUAGE': 'en_US:en', 16:38:41 INFO - 'LOGNAME': 'cltbld', 16:38:41 INFO - 'MAIL': '/var/mail/cltbld', 16:38:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:41 INFO - 'MOZ_NO_REMOTE': '1', 16:38:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:41 INFO - 'NO_EM_RESTART': '1', 16:38:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:41 INFO - 'PWD': '/builds/slave/test', 16:38:41 INFO - 'SHELL': '/bin/bash', 16:38:41 INFO - 'SHLVL': '1', 16:38:41 INFO - 'TERM': 'linux', 16:38:41 INFO - 'TMOUT': '86400', 16:38:41 INFO - 'USER': 'cltbld', 16:38:41 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1503013085.451569-1706368872', 16:38:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:41 INFO - '_': '/tools/buildbot/bin/python'} 16:38:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:42 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:38:42 INFO - Cleaning up... 16:38:42 INFO - Return code: 0 16:38:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:38:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:38:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:38:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:42 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 0xb701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc74a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe17c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe14cc0>, '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 0xe15cd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe16160>, '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': '41a7e32711b8e08598a63237000001d6-1503013085.451569-1706368872', '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 16:38:42 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 16:38:42 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 16:38:42 INFO - Using env: {'DISPLAY': ':0', 16:38:42 INFO - 'HOME': '/home/cltbld', 16:38:42 INFO - 'LANG': 'en_US.UTF-8', 16:38:42 INFO - 'LANGUAGE': 'en_US:en', 16:38:42 INFO - 'LOGNAME': 'cltbld', 16:38:42 INFO - 'MAIL': '/var/mail/cltbld', 16:38:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:42 INFO - 'MOZ_NO_REMOTE': '1', 16:38:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:42 INFO - 'NO_EM_RESTART': '1', 16:38:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:42 INFO - 'PWD': '/builds/slave/test', 16:38:42 INFO - 'SHELL': '/bin/bash', 16:38:42 INFO - 'SHLVL': '1', 16:38:42 INFO - 'TERM': 'linux', 16:38:42 INFO - 'TMOUT': '86400', 16:38:42 INFO - 'USER': 'cltbld', 16:38:42 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1503013085.451569-1706368872', 16:38:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:42 INFO - '_': '/tools/buildbot/bin/python'} 16:38:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:42 INFO - Downloading/unpacking psutil>=3.1.1 16:38:42 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 16:38:42 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 16:38:42 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 16:38:42 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 16:38:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:38:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:38:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:38:43 INFO - Installing collected packages: psutil 16:38:43 INFO - Running setup.py install for psutil 16:38:43 INFO - building 'psutil._psutil_linux' extension 16:38:43 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 16:38:43 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 16:38:43 INFO - building 'psutil._psutil_posix' extension 16:38:43 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 16:38:43 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 16:38:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:38:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:38:43 INFO - Successfully installed psutil 16:38:43 INFO - Cleaning up... 16:38:43 INFO - Return code: 0 16:38:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:38:43 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')]} 16:38:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:43 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')]} 16:38:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:43 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 0xb701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc74a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe17c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe14cc0>, '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 0xe15cd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe16160>, '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': '41a7e32711b8e08598a63237000001d6-1503013085.451569-1706368872', '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 16:38:43 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 16:38:43 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 16:38:44 INFO - Using env: {'DISPLAY': ':0', 16:38:44 INFO - 'HOME': '/home/cltbld', 16:38:44 INFO - 'LANG': 'en_US.UTF-8', 16:38:44 INFO - 'LANGUAGE': 'en_US:en', 16:38:44 INFO - 'LOGNAME': 'cltbld', 16:38:44 INFO - 'MAIL': '/var/mail/cltbld', 16:38:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:44 INFO - 'MOZ_NO_REMOTE': '1', 16:38:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:44 INFO - 'NO_EM_RESTART': '1', 16:38:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:44 INFO - 'PWD': '/builds/slave/test', 16:38:44 INFO - 'SHELL': '/bin/bash', 16:38:44 INFO - 'SHLVL': '1', 16:38:44 INFO - 'TERM': 'linux', 16:38:44 INFO - 'TMOUT': '86400', 16:38:44 INFO - 'USER': 'cltbld', 16:38:44 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1503013085.451569-1706368872', 16:38:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:44 INFO - '_': '/tools/buildbot/bin/python'} 16:38:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:38:44 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 16:38:44 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 16:38:44 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 16:38:44 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 16:38:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:38:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:38:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:38:45 INFO - Installing collected packages: mozsystemmonitor 16:38:45 INFO - Running setup.py install for mozsystemmonitor 16:38:45 INFO - Successfully installed mozsystemmonitor 16:38:45 INFO - Cleaning up... 16:38:45 INFO - Return code: 0 16:38:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:38:45 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')]} 16:38:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:45 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')]} 16:38:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:45 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 0xb701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc74a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe17c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe14cc0>, '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 0xe15cd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe16160>, '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': '41a7e32711b8e08598a63237000001d6-1503013085.451569-1706368872', '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 16:38:45 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 16:38:45 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 16:38:45 INFO - Using env: {'DISPLAY': ':0', 16:38:45 INFO - 'HOME': '/home/cltbld', 16:38:45 INFO - 'LANG': 'en_US.UTF-8', 16:38:45 INFO - 'LANGUAGE': 'en_US:en', 16:38:45 INFO - 'LOGNAME': 'cltbld', 16:38:45 INFO - 'MAIL': '/var/mail/cltbld', 16:38:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:45 INFO - 'MOZ_NO_REMOTE': '1', 16:38:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:45 INFO - 'NO_EM_RESTART': '1', 16:38:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:45 INFO - 'PWD': '/builds/slave/test', 16:38:45 INFO - 'SHELL': '/bin/bash', 16:38:45 INFO - 'SHLVL': '1', 16:38:45 INFO - 'TERM': 'linux', 16:38:45 INFO - 'TMOUT': '86400', 16:38:45 INFO - 'USER': 'cltbld', 16:38:45 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1503013085.451569-1706368872', 16:38:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:45 INFO - '_': '/tools/buildbot/bin/python'} 16:38:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:45 INFO - Downloading/unpacking jsonschema==2.5.1 16:38:45 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 16:38:45 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 16:38:45 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 16:38:45 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 16:38:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:38:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:38:46 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 16:38:46 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 16:38:46 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 16:38:46 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 16:38:46 INFO - Downloading functools32-3.2.3-2.tar.gz 16:38:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:38:47 INFO - warning: no files found matching '*.txt' 16:38:47 INFO - no previously-included directories found matching 'build' 16:38:47 INFO - no previously-included directories found matching 'dist' 16:38:47 INFO - no previously-included directories found matching '.git*' 16:38:47 INFO - Installing collected packages: jsonschema, functools32 16:38:47 INFO - Running setup.py install for functools32 16:38:47 INFO - warning: no files found matching '*.txt' 16:38:47 INFO - no previously-included directories found matching 'build' 16:38:47 INFO - no previously-included directories found matching 'dist' 16:38:47 INFO - no previously-included directories found matching '.git*' 16:38:47 INFO - Successfully installed jsonschema functools32 16:38:47 INFO - Cleaning up... 16:38:47 INFO - Return code: 0 16:38:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:38:47 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')]} 16:38:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:47 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')]} 16:38:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:47 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 0xb701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc74a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe17c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe14cc0>, '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 0xe15cd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe16160>, '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': '41a7e32711b8e08598a63237000001d6-1503013085.451569-1706368872', '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 16:38:47 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 16:38:47 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 16:38:47 INFO - Using env: {'DISPLAY': ':0', 16:38:47 INFO - 'HOME': '/home/cltbld', 16:38:47 INFO - 'LANG': 'en_US.UTF-8', 16:38:47 INFO - 'LANGUAGE': 'en_US:en', 16:38:47 INFO - 'LOGNAME': 'cltbld', 16:38:47 INFO - 'MAIL': '/var/mail/cltbld', 16:38:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:47 INFO - 'MOZ_NO_REMOTE': '1', 16:38:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:47 INFO - 'NO_EM_RESTART': '1', 16:38:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:47 INFO - 'PWD': '/builds/slave/test', 16:38:47 INFO - 'SHELL': '/bin/bash', 16:38:47 INFO - 'SHLVL': '1', 16:38:47 INFO - 'TERM': 'linux', 16:38:47 INFO - 'TMOUT': '86400', 16:38:47 INFO - 'USER': 'cltbld', 16:38:47 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1503013085.451569-1706368872', 16:38:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:47 INFO - '_': '/tools/buildbot/bin/python'} 16:38:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:38:47 INFO - Cleaning up... 16:38:47 INFO - Return code: 0 16:38:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:38:47 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')]} 16:38:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:47 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')]} 16:38:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:47 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 0xb701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc74a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe17c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe14cc0>, '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 0xe15cd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe16160>, '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': '41a7e32711b8e08598a63237000001d6-1503013085.451569-1706368872', '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 16:38:47 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 16:38:47 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 16:38:47 INFO - Using env: {'DISPLAY': ':0', 16:38:47 INFO - 'HOME': '/home/cltbld', 16:38:47 INFO - 'LANG': 'en_US.UTF-8', 16:38:47 INFO - 'LANGUAGE': 'en_US:en', 16:38:47 INFO - 'LOGNAME': 'cltbld', 16:38:47 INFO - 'MAIL': '/var/mail/cltbld', 16:38:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:47 INFO - 'MOZ_NO_REMOTE': '1', 16:38:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:47 INFO - 'NO_EM_RESTART': '1', 16:38:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:47 INFO - 'PWD': '/builds/slave/test', 16:38:47 INFO - 'SHELL': '/bin/bash', 16:38:47 INFO - 'SHLVL': '1', 16:38:47 INFO - 'TERM': 'linux', 16:38:47 INFO - 'TMOUT': '86400', 16:38:47 INFO - 'USER': 'cltbld', 16:38:47 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1503013085.451569-1706368872', 16:38:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:47 INFO - '_': '/tools/buildbot/bin/python'} 16:38:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:47 INFO - Downloading/unpacking blobuploader==1.2.4 16:38:47 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 16:38:47 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 16:38:47 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 16:38:47 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 16:38:48 INFO - Downloading blobuploader-1.2.4.tar.gz 16:38:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:38:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:38:48 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 16:38:48 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 16:38:48 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 16:38:48 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 16:38:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:38:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:38:49 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 16:38:49 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 16:38:49 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 16:38:49 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 16:38:49 INFO - Downloading docopt-0.6.1.tar.gz 16:38:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:38:49 INFO - Installing collected packages: blobuploader, requests, docopt 16:38:49 INFO - Running setup.py install for blobuploader 16:38:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:38:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:38:49 INFO - Running setup.py install for requests 16:38:49 INFO - Running setup.py install for docopt 16:38:49 INFO - Successfully installed blobuploader requests docopt 16:38:49 INFO - Cleaning up... 16:38:49 INFO - Return code: 0 16:38:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:38:49 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')]} 16:38:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:49 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')]} 16:38:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:49 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 0xb701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc74a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe17c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe14cc0>, '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 0xe15cd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe16160>, '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': '41a7e32711b8e08598a63237000001d6-1503013085.451569-1706368872', '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 16:38:49 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 16:38:49 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 16:38:49 INFO - Using env: {'DISPLAY': ':0', 16:38:49 INFO - 'HOME': '/home/cltbld', 16:38:49 INFO - 'LANG': 'en_US.UTF-8', 16:38:49 INFO - 'LANGUAGE': 'en_US:en', 16:38:49 INFO - 'LOGNAME': 'cltbld', 16:38:49 INFO - 'MAIL': '/var/mail/cltbld', 16:38:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:49 INFO - 'MOZ_NO_REMOTE': '1', 16:38:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:49 INFO - 'NO_EM_RESTART': '1', 16:38:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:49 INFO - 'PWD': '/builds/slave/test', 16:38:49 INFO - 'SHELL': '/bin/bash', 16:38:49 INFO - 'SHLVL': '1', 16:38:49 INFO - 'TERM': 'linux', 16:38:49 INFO - 'TMOUT': '86400', 16:38:49 INFO - 'USER': 'cltbld', 16:38:49 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1503013085.451569-1706368872', 16:38:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:49 INFO - '_': '/tools/buildbot/bin/python'} 16:38:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:38:50 INFO - Running setup.py (path:/tmp/pip-0CbAP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:38:50 INFO - Running setup.py (path:/tmp/pip-nPYt_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:38:50 INFO - Running setup.py (path:/tmp/pip-a5X0Xv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:38:50 INFO - Running setup.py (path:/tmp/pip-z5OAac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:38:50 INFO - Running setup.py (path:/tmp/pip-7dExvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:38:50 INFO - Running setup.py (path:/tmp/pip-KmbY_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:38:50 INFO - Running setup.py (path:/tmp/pip-A6Drfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:38:50 INFO - Running setup.py (path:/tmp/pip-0EXksX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:38:50 INFO - Running setup.py (path:/tmp/pip-KU_ekY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:38:50 INFO - Running setup.py (path:/tmp/pip-15UEYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:38:50 INFO - Running setup.py (path:/tmp/pip-TJw3h7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:38:50 INFO - Running setup.py (path:/tmp/pip-NcDwNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:38:51 INFO - Running setup.py (path:/tmp/pip-pxaTWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:38:51 INFO - Running setup.py (path:/tmp/pip-yemykN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:38:51 INFO - Running setup.py (path:/tmp/pip-mX9mKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:38:51 INFO - Running setup.py (path:/tmp/pip-28PHOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:38:51 INFO - Running setup.py (path:/tmp/pip-iFM8Cq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:38:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:38:51 INFO - Running setup.py install for manifestparser 16:38:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:38:51 INFO - Running setup.py install for mozcrash 16:38:51 INFO - Running setup.py install for mozdebug 16:38:51 INFO - Running setup.py install for mozdevice 16:38:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:38:51 INFO - Running setup.py install for mozfile 16:38:51 INFO - Running setup.py install for mozhttpd 16:38:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:38:51 INFO - Running setup.py install for mozinfo 16:38:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:38:52 INFO - Running setup.py install for mozInstall 16:38:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:38:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:38:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:38:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:38:52 INFO - Running setup.py install for mozleak 16:38:52 INFO - Running setup.py install for mozlog 16:38:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:38:52 INFO - Running setup.py install for moznetwork 16:38:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:38:52 INFO - Running setup.py install for mozprocess 16:38:52 INFO - Running setup.py install for mozprofile 16:38:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:38:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:38:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:38:52 INFO - Running setup.py install for mozrunner 16:38:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:38:52 INFO - Running setup.py install for mozscreenshot 16:38:52 INFO - Running setup.py install for moztest 16:38:53 INFO - Running setup.py install for mozversion 16:38:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:38:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:38:53 INFO - Cleaning up... 16:38:53 INFO - Return code: 0 16:38:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:38: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')]} 16:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38: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')]} 16:38:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:53 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 0xb701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc74a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe17c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe14cc0>, '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 0xe15cd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe16160>, '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': '41a7e32711b8e08598a63237000001d6-1503013085.451569-1706368872', '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 16:38:53 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 16:38:53 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 16:38:53 INFO - Using env: {'DISPLAY': ':0', 16:38:53 INFO - 'HOME': '/home/cltbld', 16:38:53 INFO - 'LANG': 'en_US.UTF-8', 16:38:53 INFO - 'LANGUAGE': 'en_US:en', 16:38:53 INFO - 'LOGNAME': 'cltbld', 16:38:53 INFO - 'MAIL': '/var/mail/cltbld', 16:38:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:53 INFO - 'MOZ_NO_REMOTE': '1', 16:38:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:53 INFO - 'NO_EM_RESTART': '1', 16:38:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:53 INFO - 'PWD': '/builds/slave/test', 16:38:53 INFO - 'SHELL': '/bin/bash', 16:38:53 INFO - 'SHLVL': '1', 16:38:53 INFO - 'TERM': 'linux', 16:38:53 INFO - 'TMOUT': '86400', 16:38:53 INFO - 'USER': 'cltbld', 16:38:53 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1503013085.451569-1706368872', 16:38:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:53 INFO - '_': '/tools/buildbot/bin/python'} 16:38:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:38:53 INFO - Running setup.py (path:/tmp/pip-Pelydx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:38:53 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)) 16:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:38:53 INFO - Running setup.py (path:/tmp/pip-gJu5Uq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:38:53 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)) 16:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:38:53 INFO - Running setup.py (path:/tmp/pip-yjyyy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:38:53 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)) 16:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:38:53 INFO - Running setup.py (path:/tmp/pip-0cwvK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:38:53 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)) 16:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:38:53 INFO - Running setup.py (path:/tmp/pip-5y9U_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:38:53 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)) 16:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:38:53 INFO - Running setup.py (path:/tmp/pip-WZS1Uz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:38:53 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)) 16:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:38:53 INFO - Running setup.py (path:/tmp/pip-oG564i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:38:53 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)) 16:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:38:53 INFO - Running setup.py (path:/tmp/pip-7ipW1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:38:53 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)) 16:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:38:53 INFO - Running setup.py (path:/tmp/pip-WXGQFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:38:54 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)) 16:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:38:54 INFO - Running setup.py (path:/tmp/pip-nttS5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:38:54 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)) 16:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:38:54 INFO - Running setup.py (path:/tmp/pip-qBrTm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:38:54 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)) 16:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:38:54 INFO - Running setup.py (path:/tmp/pip-duCGHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:38:54 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)) 16:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:38:54 INFO - Running setup.py (path:/tmp/pip-ah_Oxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:38:54 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)) 16:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:38:54 INFO - Running setup.py (path:/tmp/pip-Y6IxxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:38:54 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)) 16:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:38:54 INFO - Running setup.py (path:/tmp/pip-Ejxp9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:38:54 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)) 16:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:38:54 INFO - Running setup.py (path:/tmp/pip-0odk_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:38:54 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)) 16:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:38:54 INFO - Running setup.py (path:/tmp/pip-CfretA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:38:54 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)) 16:38:54 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)) 16:38:54 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)) 16:38:54 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)) 16:38:54 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)) 16:38:54 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)) 16:38:54 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)) 16:38:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:38:54 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 16:38:54 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 16:38:54 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 16:38:54 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 16:38:55 INFO - Downloading blessings-1.6.tar.gz 16:38:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:38:55 INFO - Installing collected packages: blessings 16:38:55 INFO - Running setup.py install for blessings 16:38:55 INFO - Successfully installed blessings 16:38:55 INFO - Cleaning up... 16:38:55 INFO - Return code: 0 16:38:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:38:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:38:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:38:56 INFO - Reading from file tmpfile_stdout 16:38:56 INFO - Current package versions: 16:38:56 INFO - argparse == 1.2.1 16:38:56 INFO - blessings == 1.6 16:38:56 INFO - blobuploader == 1.2.4 16:38:56 INFO - docopt == 0.6.1 16:38:56 INFO - functools32 == 3.2.3-2 16:38:56 INFO - jsonschema == 2.5.1 16:38:56 INFO - manifestparser == 1.1 16:38:56 INFO - mozInstall == 1.13 16:38:56 INFO - mozcrash == 1.0 16:38:56 INFO - mozdebug == 0.1 16:38:56 INFO - mozdevice == 0.51 16:38:56 INFO - mozfile == 1.2 16:38:56 INFO - mozhttpd == 0.7 16:38:56 INFO - mozinfo == 0.10 16:38:56 INFO - mozleak == 0.1 16:38:56 INFO - mozlog == 3.5 16:38:56 INFO - moznetwork == 0.27 16:38:56 INFO - mozprocess == 0.25 16:38:56 INFO - mozprofile == 0.28 16:38:56 INFO - mozrunner == 6.13 16:38:56 INFO - mozscreenshot == 0.1 16:38:56 INFO - mozsystemmonitor == 0.3 16:38:56 INFO - moztest == 0.8 16:38:56 INFO - mozversion == 1.4 16:38:56 INFO - psutil == 3.1.1 16:38:56 INFO - requests == 1.2.3 16:38:56 INFO - wsgiref == 0.1.2 16:38:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:38:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:38:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:56 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 0xb701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc74a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe17c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe14cc0>, '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 0xe15cd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe16160>, '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': '41a7e32711b8e08598a63237000001d6-1503013085.451569-1706368872', '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 16:38:56 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 16:38:56 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 16:38:56 INFO - Using env: {'DISPLAY': ':0', 16:38:56 INFO - 'HOME': '/home/cltbld', 16:38:56 INFO - 'LANG': 'en_US.UTF-8', 16:38:56 INFO - 'LANGUAGE': 'en_US:en', 16:38:56 INFO - 'LOGNAME': 'cltbld', 16:38:56 INFO - 'MAIL': '/var/mail/cltbld', 16:38:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:56 INFO - 'MOZ_NO_REMOTE': '1', 16:38:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:56 INFO - 'NO_EM_RESTART': '1', 16:38:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:56 INFO - 'PWD': '/builds/slave/test', 16:38:56 INFO - 'SHELL': '/bin/bash', 16:38:56 INFO - 'SHLVL': '1', 16:38:56 INFO - 'TERM': 'linux', 16:38:56 INFO - 'TMOUT': '86400', 16:38:56 INFO - 'USER': 'cltbld', 16:38:56 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1503013085.451569-1706368872', 16:38:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:56 INFO - '_': '/tools/buildbot/bin/python'} 16:38:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:56 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)) 16:38:56 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)) 16:38:56 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)) 16:38:56 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)) 16:38:56 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)) 16:38:56 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)) 16:38:56 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)) 16:38:56 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)) 16:38:56 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)) 16:38:56 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:38:56 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 16:38:56 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 16:38:56 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 16:38:56 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 16:38:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:38:57 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)) 16:38:57 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)) 16:38:57 INFO - Installing collected packages: simplejson 16:38:57 INFO - Running setup.py install for simplejson 16:38:57 INFO - building 'simplejson._speedups' extension 16:38:57 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 16:38:58 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 16:38:58 INFO - Successfully installed simplejson 16:38:58 INFO - Cleaning up... 16:38:58 INFO - Return code: 0 16:38:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:38:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:38:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc74a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe17c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe14cc0>, '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 0xe15cd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe16160>, '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': '41a7e32711b8e08598a63237000001d6-1503013085.451569-1706368872', '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 16:38:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:38:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:38:58 INFO - Using env: {'DISPLAY': ':0', 16:38:58 INFO - 'HOME': '/home/cltbld', 16:38:58 INFO - 'LANG': 'en_US.UTF-8', 16:38:58 INFO - 'LANGUAGE': 'en_US:en', 16:38:58 INFO - 'LOGNAME': 'cltbld', 16:38:58 INFO - 'MAIL': '/var/mail/cltbld', 16:38:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:58 INFO - 'MOZ_NO_REMOTE': '1', 16:38:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:58 INFO - 'NO_EM_RESTART': '1', 16:38:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:58 INFO - 'PWD': '/builds/slave/test', 16:38:58 INFO - 'SHELL': '/bin/bash', 16:38:58 INFO - 'SHLVL': '1', 16:38:58 INFO - 'TERM': 'linux', 16:38:58 INFO - 'TMOUT': '86400', 16:38:58 INFO - 'USER': 'cltbld', 16:38:58 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1503013085.451569-1706368872', 16:38:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:58 INFO - '_': '/tools/buildbot/bin/python'} 16:38:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:38:59 INFO - Cleaning up... 16:38:59 INFO - Return code: 0 16:38:59 INFO - Running post-action listener: _resource_record_post_action 16:38:59 INFO - Running post-action listener: _start_resource_monitoring 16:38:59 INFO - Starting resource monitoring. 16:38:59 INFO - [mozharness: 2017-08-17 23:38:59.104606Z] Finished create-virtualenv step (success) 16:38:59 INFO - [mozharness: 2017-08-17 23:38:59.105121Z] Running install step. 16:38:59 INFO - Running pre-action listener: _resource_record_pre_action 16:38:59 INFO - Running main action method: install 16:38:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:38:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:38:59 INFO - Reading from file tmpfile_stdout 16:38:59 INFO - Detecting whether we're running mozinstall >=1.0... 16:38:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:38:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:38:59 INFO - Reading from file tmpfile_stdout 16:38:59 INFO - Output received: 16:38:59 INFO - Usage: mozinstall [options] installer 16:38:59 INFO - Options: 16:38:59 INFO - -h, --help show this help message and exit 16:38:59 INFO - -d DEST, --destination=DEST 16:38:59 INFO - Directory to install application into. [default: 16:38:59 INFO - "/builds/slave/test"] 16:38:59 INFO - --app=APP Application being installed. [default: firefox] 16:38:59 INFO - mkdir: /builds/slave/test/build/application 16:38:59 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'] 16:38:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:39:17 INFO - Reading from file tmpfile_stdout 16:39:17 INFO - Output received: 16:39:17 INFO - /builds/slave/test/build/application/firefox/firefox 16:39:17 INFO - Running post-action listener: _resource_record_post_action 16:39:17 INFO - [mozharness: 2017-08-17 23:39:17.476037Z] Finished install step (success) 16:39:17 INFO - [mozharness: 2017-08-17 23:39:17.476325Z] Running setup-mitmproxy step. 16:39:17 INFO - Running pre-action listener: _resource_record_pre_action 16:39:17 INFO - Running main action method: setup_mitmproxy 16:39:17 INFO - Skipping: mitmproxy is not required 16:39:17 INFO - Running post-action listener: _resource_record_post_action 16:39:17 INFO - [mozharness: 2017-08-17 23:39:17.477482Z] Finished setup-mitmproxy step (success) 16:39:17 INFO - [mozharness: 2017-08-17 23:39:17.477771Z] Running run-tests step. 16:39:17 INFO - Running pre-action listener: _resource_record_pre_action 16:39:17 INFO - Running pre-action listener: _set_gcov_prefix 16:39:17 INFO - Running main action method: run_tests 16:39:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:39:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:39:17 INFO - Python 2.7.3 16:39:17 INFO - Return code: 0 16:39:17 INFO - grabbing minidump binary from tooltool 16:39:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:39:17 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe14cc0>, '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 0xe15cd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe16160>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:39:17 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:39:17 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:39:17 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:39:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:39:17 INFO - Return code: 0 16:39:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:39:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:39:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:39:17 INFO - ENV: RUST_BACKTRACE is now full 16:39:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:39:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:39:17 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/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 16:39:17 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/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-024 --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 16:39:17 INFO - Using env: {'DISPLAY': ':0', 16:39:17 INFO - 'HOME': '/home/cltbld', 16:39:17 INFO - 'LANG': 'en_US.UTF-8', 16:39:17 INFO - 'LANGUAGE': 'en_US:en', 16:39:17 INFO - 'LOGNAME': 'cltbld', 16:39:17 INFO - 'MAIL': '/var/mail/cltbld', 16:39:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:39:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:39:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:17 INFO - 'MOZ_NO_REMOTE': '1', 16:39:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:39:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:39:17 INFO - 'NO_EM_RESTART': '1', 16:39:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:39:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:17 INFO - 'PWD': '/builds/slave/test', 16:39:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:39:17 INFO - 'RUST_BACKTRACE': 'full', 16:39:17 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:39:17 INFO - 'SHELL': '/bin/bash', 16:39:17 INFO - 'SHLVL': '1', 16:39:17 INFO - 'STYLO_FORCE_ENABLED': '1', 16:39:17 INFO - 'TERM': 'linux', 16:39:17 INFO - 'TMOUT': '86400', 16:39:17 INFO - 'USER': 'cltbld', 16:39:17 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1503013085.451569-1706368872', 16:39:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:17 INFO - '_': '/tools/buildbot/bin/python'} 16:39:17 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/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 16:39:17 INFO - mozversion application_buildid: 20170817223319 16:39:17 INFO - mozversion application_changeset: 2fb6d8f7bac1be26b2b49b68fc34cc6decd7f339 16:39:17 INFO - mozversion application_display_name: Nightly 16:39:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:39:17 INFO - mozversion application_name: Firefox 16:39:17 INFO - mozversion application_remotingname: firefox 16:39:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:39:17 INFO - mozversion application_vendor: Mozilla 16:39:17 INFO - mozversion application_version: 57.0a1 16:39:17 INFO - mozversion platform_buildid: 20170817223319 16:39:17 INFO - mozversion platform_changeset: 2fb6d8f7bac1be26b2b49b68fc34cc6decd7f339 16:39:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:39:17 INFO - mozversion platform_version: 57.0a1 16:39:17 INFO - using testdate: 1503013157 16:39:17 INFO - actual date: 1503013157 16:39:17 INFO - starting webserver on 'localhost:49201' 16:39:17 INFO - SUITE-START | Running 2 tests 16:39:17 INFO - TEST-START | dromaeo_css 16:39:17 INFO - Initialising browser for dromaeo_css test... 16:39:17 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49201/getInfo.html -profile /tmp/tmpkqk4vI/profile 16:39:17 INFO - TEST-INFO | started process 30388 (/builds/slave/test/build/application/firefox/firefox http://localhost:49201/getInfo.html) 16:39:23 INFO - TEST-INFO | 30388: exit 0 16:39:24 INFO - Browser initialized. 16:39:24 INFO - Running cycle 1/1 for dromaeo_css test... 16:39:24 INFO - TEST-INFO | started process 30579 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkqk4vI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:39:25 INFO - PID 30579 | 16:39:25 INFO - PID 30579 | (/builds/slave/test/build/application/firefox/firefox:30634): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:39:25 INFO - PID 30579 | 16:39:35 INFO - PID 30579 | RSS: Main: 166563840 16:39:35 INFO - PID 30579 | 16:42:34 INFO - PID 30579 | Cycle 1(1): loaded http://localhost:49201/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49201/tests/dromaeo/cssquery-ext.html) 16:42:36 INFO - PID 30579 | RSS: Main: 174424064 16:42:36 INFO - PID 30579 | 16:45:38 INFO - PID 30579 | Cycle 1(1): loaded http://localhost:49201/tests/dromaeo/cssquery-ext.html (next: http://localhost:49201/tests/dromaeo/cssquery-jquery.html) 16:45:38 INFO - PID 30579 | RSS: Main: 171868160 16:45:38 INFO - PID 30579 | 16:48:40 INFO - PID 30579 | Cycle 1(1): loaded http://localhost:49201/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49201/tests/dromaeo/cssquery-mootools.html) 16:48:41 INFO - PID 30579 | RSS: Main: 174145536 16:48:41 INFO - PID 30579 | 16:51:42 INFO - PID 30579 | Cycle 1(1): loaded http://localhost:49201/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49201/tests/dromaeo/cssquery-prototype.html) 16:51:43 INFO - PID 30579 | RSS: Main: 172072960 16:51:43 INFO - PID 30579 | 16:54:46 INFO - PID 30579 | Cycle 1(1): loaded http://localhost:49201/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49201/tests/dromaeo/cssquery-yui.html) 16:54:47 INFO - PID 30579 | RSS: Main: 175448064 16:54:47 INFO - PID 30579 | 16:57:49 INFO - PID 30579 | Cycle 1(1): loaded http://localhost:49201/tests/dromaeo/cssquery-yui.html (next: http://localhost:49201/tests/dromaeo/cssquery-dojo.html) 16:57:49 INFO - PID 30579 | RSS: Main: 176226304 16:57:49 INFO - PID 30579 | 16:57:49 INFO - PID 30579 | __start_tp_report 16:57:49 INFO - PID 30579 | _x_x_mozilla_page_load 16:57:49 INFO - PID 30579 | _x_x_mozilla_page_load_details 16:57:49 INFO - PID 30579 | |i|pagename|runs| 16:57:49 INFO - PID 30579 | |0;dojo.html;3161.193895556633;3188.697073777991;3190.2981344104296;3202.807831530107;3216.6944140306664;6179.969100154504;6207.472364848988;6248.84377890553;6249.093881387196;6273.996160614302;6039.72821223045;6044.576879618428;6071.757129714806;6121.173641558388;6200.286966998797;5660.5471562275025;5661.405552416999;5681.062624666945;5704.54363650909;5727.971360143193;5664.518515926151;5685.829425117233;5704.572157088235;5728.68492232927;5745.770169193248;5685.687287199203;5740.827775166731;5742.856428589277;5764.308283006045;5765.6540607563475;5544.3346798384455;5721.656700597978;5791.247137872071;5793.768249270045;5819.505342045931;5582.218489411485;5584.078627026536;5593.608447408683;5649.209110724501;5676.97814393409;6029.758809647609;6084.726187321537;6206.844828879269;6225.28409232935;6231.127642130105;6509.1863517060365;6625.4037136657935;6627.602343859384;6647.933520664828;6708.429783468411;6630.801075967729;6678.031685405637;6684.231313398924;6687.565308254996;6689.665516724193;6179.0422484514975;6179.598326108789;6248.4376406123665;6255.718492667841;6259.37406259375;6838.692258848364;6911.827204319932;6931.930680693229;6956.060931774247;6958.234594194634;6449.451796597248;6524.804255872332;6572.901406478906;6635.900461493082;6661.600303981777;6460.3216662250725;6532.5753826001155;6533.052707357407;6555.180602424697;6564.442022428051;6499.805005849832;6554.7378104876225;6561.868762624721;6572.572782769104;6574.342565743483;6572.211334639874;6574.474042076622;6591.736330546724;6604.240512341143;6604.669766511655;5402.594805389612;5417.052015897202;5420.430854760272;5423.593230507728;5449.536789372868;4667.929981050287;4681.789319480631;4692.319613656069;4693.671442998957;4710.29345598163;5649.096144616841;5701.030824759718;5715.971420142872;5735.11105778605;5738.655680659173;6588.110605068255;6678.09845670838;6690.230623478362;6721.966390168018;6761.797146085625;5691.146328050825;5729.455701708331;5765.1928729977835;5809.593328467051;5821.214136091573;5767.740451679684;5850.707464626752;5852.326982397079;5853.590248682552;5953.3451320354725;6393.808185754435;6404.519661025442;6414.294427612959;6418.711157997808;6419.45434638061;6581.308962558863;6613.66931653425;6685.064091027163;6728.596284222962;6802.3537763912345;6483.513736469878;6488.253850807028;6510.902336465051;6580.605163690194;6618.768343107968;6370.362963703593;6434.420902118832;6551.541392102507;6648.368405001517;6653.933460665331;6649.800505984828;6651.16860392451;6664.833379165366;6669.166354205724;6697.8325541859895;6343.5876668016435;6421.71102300407;6426.29310775805;6434.453071488976;6437.967810160919;6405.03924411342;6408.487321014214;6418.871622567429;6420.839479013062;6427.389398007182;6381.617102973651;6389.361063893573;6436.066770318184;6459.224893012869;6463.709133089116;6543.280239173592;6565.835854103686;6583.242927063257;6583.769568065095;6589.538732288694;6303.212098487689;6322.589031712924;6331.05034244867;6412.583182093149;6434.163558737334 16:57:49 INFO - PID 30579 | |1;ext.html;759.2673070486983;843.5866425451528;873.921347078763;874.090945416767;1163.6218229075541;30362.848185759096;42117.78941105294;43269;43313.35029974545;43448.13103737924;42565.36151957723;42950.57049429505;42969;43000.35499467511;43043.35434968478;5738.139279108125;5870.823875283727;7609.048868891388;7741.8838717419285;7765.378769698411;7569.697212111537;7718.652660630285;7735.226477352276;7743.419243556727;7746.9225307746765;7698.461107722462;7724.266194711493;7741.071071471431;7742.303192712655;7749.186335434782;7673.117591476996;7717.151113377524;7732.961335193288;7733.8066548336465;7736.381089512825;7530.359919406857;7570.545767253982;7573.280538348903;7579.052618422697;7609.847803043908;38485.037874053094;38754.22491550153;38807.029824254336;38847;38880.41679374812;3615.403458429356;3652.105234217607;3657.963420365789;3660.432632941898;3660.524131862841;30596.69403305983;30639.69360306413;30687.386252275053;30734;30775.846120769478;4834.202356611155;4845.370101886768;4846.39420072491;4867.586255168315;4873.805047798084;190029.9999999986;190185;190306;190469;190629;47948.520514795106;48222.758886205345;48362.27456588154;48426.515734842906;48430.5156948426;50788.74605626948;50823;50855;50918.92648588104;50964.74517627388;13715.725685486233;14012.649683757987;14025.859741402659;14033.78949315761;14070.71858562823;11056.281341712764;11162.441877906234;11344.886551134548;11345;11357.261777984404;12077.335746534025;13567.118137321042;14212.786808197678;14219.928900355431;14241.78637320441;5339.599530035185;5443.401225865152;5507.834764957058;5508.091164957737;5579.358373786985;1004.437514991607;1007.5163921317809;1016.7254841192985;1026.2098184397971;1027.5735569738474;23113.653295200584;23678.64482032771;28562.428751424854;29004.68817161309;29839.254018649706;1071.5445935477392;1075.1774892207468;1081.9891801081887;1084.311462221495;1094.6497120921229;12671.746565068832;12915.935420322838;12954.611361659165;12968.09223354375;13026.892714119405;230642;230887;231907;232190;232208;53508.73245633825;53526.19710704342;53657;53795.46204537983;53848.46151538513;1400.26486094799;1444.227338373986;1452.5787521618613;1467.6257554323793;1470.4559313054237;22678;22932.77067229373;23045.07819687194;23177.652335215324;23362.415939601648;38383.80808095942;38429.6157038426;38463.230735385696;38509.614903850605;38526.229475410895;191698;193884;195463;196367;196557;34555.30889382248;34724.47913281252;34769.478457822646;34877.47683784796;35027.649723502436;40918.590814091476;42448.15103697847;47301.763491182326;48313;49098.26352604642;34188.14529636779;34536.48195277123;34793.086380249326;34886;35324.646753532135;33899.66100338965;34280;34345.656543435245;34468.65531344654;34608.134796630286;31395.372092557565;31495.52756708697;31496.055118346485;31589.36821263608;31603;33101.503477447375;33205.169870752456;33478.497822533165;33609.83195084009;33854.492182616785;24295.934845538326;24683.876580616983;25449.745502544738;25554.6368336638;25767.613485797352 16:57:49 INFO - PID 30579 | |2;jquery.html;568.4940403041293;571.4143003421495;572.3217986685778;575.7524264566238;597.2355385107063;21979.23072692454;22747;22976.88511557442;23032.884835575842;23080.88459557702;26150.73849261507;26493.602595961074;26497.470050598975;26645.733542664566;26657.333566660844;6510.479161667079;6637.93362066378;6647.534672572921;6654.101696271014;6677.2988836172235;6135.3557876423;6479.384458476437;6480.416762491375;6494;6533.60798352098;6442.033694945772;6448.387403196689;6448.838779030515;6456.225252969627;6457.580257283285;6457.2896981332015;6460.709268082947;6464.191976003;6473.8705225895455;6477.157969463963;6015.248093988252;6020.819375418744;6029.427204415573;6036.034234522455;6036.9698151508965;29011.564826527618;30035.549466758017;30115.69884301151;30221.697783022108;30614.081577552486;1876.9249230030782;1888.6694828404975;1901.5816520365497;1907.7043058325983;1909.5703466720015;19388.12753426099;20105.095270712853;20115.798842011685;20126.899365503225;20129.698054529195;2321.3152120124605;2335.5679199348006;2370.0875163062174;2373.8100951923975;2465.408302007523;139470;147141.99999999892;147498;147532;147565.26217368845;14752.926235368968;14876.925615371854;15044.62388440276;15464.690706185813;15902.284397202153;22843.657345139836;23289.53420931572;23477.765222347898;23538.764612353658;24045;9479.146876781122;9595.856062159073;9723.367981081206;9733.853992190123;9740.512974351253;8656.61045252965;8658.48049117055;8659.610317535726;8692.608832602547;8741.562921853882;9584.520773961274;9786.804263914682;9871.50642467888;9871.703848884545;9894.80210395788;2727.263638817548;2763.350612606036;2797.3146579087847;2809.2555472799722;2821.830690158597;963.1764841060932;981.5877331520778;982.5529384130203;988.7280997725683;994.3636072913341;19733.40799776009;19902.50243743889;20083.397498075083;20481;20757.688634670492;1035.2856528994969;1035.5650626736638;1047.1256500821746;1047.6333283350766;1051.3849398102043;10973.122150227962;11184.776304474028;11187.105031597453;11217.326960382403;11418.486168122454;516056;529863;543645;544879;548254;119225;124149;124387;125080;126247;1164.441068287227;1194.3431112887877;1215.4348228073989;1216.5498765456837;1219.0430512048;17745.556361091076;17797.377091801725;17842.375516856846;18020.36928707489;18146.364877229233;57095.42904570901;57908.4209157903;59401;61774;63240.68379658072;72020;72558.27441725726;72777.27222727705;72816;73220.63389683017;14776.926115369355;15204.637449403006;15314;15347.386104555693;15363.308651110503;23625.173118940755;23757.218208634768;23869.761302387447;23897.522049558564;24082.39794005164;17666.5583360417;17767.378141764977;17817.376391826223;18860.905695471436;19062.142203600593;16821.663566728843;17114.657706845544;17639.118044098;17641.911790440965;18396.81603183951;19115;19177.424677259703;19378.321758738377;19421.126049328097;19442.222311107398;14780.408783648963;14867.702645947236;14914.105153690813;14919.403223870924;14953.700925981202;18085.276588936296;18164.545886352946;18215.908920455844;18223.635527289644;18417 16:57:49 INFO - PID 30579 | |3;mootools.html;1410.1820943852567;1463.7145756577465;1465.6628975335673;1478.94426746822;1489.897475867858;13767.380467878944;14325.068870523435;14381.280935953188;14403.783943240847;14412.711745765078;13996.860031399683;14133.434662613508;14139.717205655881;14140.222287774168;14152.575422737335;2647.073524266506;2676.9063082792104;2682.932926676829;2685.073649590888;2689.7444742749503;2537.708163561186;2615.973840261592;2620.751028652275;2636.841789492627;2642.9339266518396;2519.760622740837;2526.090607381341;2540.6697129373156;2560.4111054457485;2560.8335458195156;2488.14159115105;2506.1980166346775;2511.033252197908;2519.004993027762;2522.432452698147;2410.5178964207053;2435.2207293666033;2439.8536087834786;2442.511497700449;2455.2756936703713;13751.793723094162;14381.568552943429;14421.567352979428;14428.278586070759;14434.783478247835;7580.469367144302;7885;7888.605569721491;7888.80277993049;7895.763127106196;4858.29554714568;5062.747077550492;5154.690718556899;5199.4800519948085;5203.505666961671;1781.9554511137326;1799.7660304160506;1828.7256911463253;1845.6308738252403;1850.370873902866;22788.31635050951;22945.655815162787;22966.311010669706;22971.310860674206;22997.19509817165;6459.61242325462;6574.211094668671;6587.077809106729;6738.494612903954;6748.595084294958;15875.761863572056;15883.920580397024;15890.60273493172;15902.522924312289;15927.362905483882;7343.816404589821;7481.064866891638;7485.251474852471;7510.061242344707;7512;6867.553609015398;6870.416014638811;6885.758998435031;6976.895346569806;6983.511154219156;4991.401031876198;5105.361829771278;5141.76862041209;5158.458361872024;5172.5344718975475;1478.0762023735165;1480.267267702494;1482.0959214878915;1498.595379247619;1501.5120085972103;915.8031023330016;925.4771054354268;934.3086116273909;944.0323668239971;944.8677185194078;7309.232530584212;7431.479796414199;7488.850222995509;7585.089789225218;7686.884696729554;694.7047504810436;727.3562896836232;730.9926900730925;743.9181690014094;754.8414832885155;4781.330613714083;5058.038972595195;5070.569001634903;5114.207297868837;5364.624476286623;18627;18698.626027479375;19335.51661208481;19446.80553194478;19481.415557533295;18911.14899829511;18963.90518047401;19015.239390424504;19263.51841203953;19263.711044334344;10534.525946332433;10540;10910.23628346024;11037.0618497427;11049.779004420026;8188.877166842383;8466.449680770731;8638.395312328328;8743.650253989768;8775;16797.32810687559;17236.396726114526;17263.654726905643;17383;17463.47609571715;17197;17273;17316.480505584852;17392.391266305618;17481;11381.260218085798;11561.768764624829;11562.76874462523;11633.360165190996;11646.24299420535;12877.227366358049;12917.61247162549;12987.545435909698;13019.153755005895;13061.477540898637;10601.25791194609;10689.94655026751;10747.570097196338;10856.2400631955;10934.453277335942;10626.309289896131;10669.199810014436;10693.51879165455;10870.836937446104;11045.668629941114;9250;9256.768580785534;9328.253739700944;9364.719058428258;9378.155965963097;7035.964820175866;7059.752908648173;7119.715211391486;7128.215896251512;7138.072050633385;7274.563526188445;7327.340539351484;7334.559926404433;7402.1117465904435;7404.740834070997 16:57:49 INFO - PID 30579 | |4;prototype.html;491.8917838075622;519.906416844968;525.6609486880959;530.2470491901499;532.2681313194357;5975.402459754023;6008.519318454524;6020.729067191976;6038.8490287742825;6068.514518838493;5922.703864806764;5999.160117583542;5999.340072592022;6000.4098913787775;6014.789482368118;5022.296878437012;5031.396232452093;5055.216441451581;5067.113255180348;5068.34111565496;4662.51043640418;4821.276808478721;4927.605791536668;4945.530174633422;4997;4768.308595253686;4820.710757354553;4821.566059054684;4844.467108618049;4851.830185943492;4795.448523419816;4829.372181616385;4834;4859.246816743375;4874.244492103712;4219.767912764797;4343.391925130484;4348.2607956647125;4371.038371558252;4386.451693538308;5772.5670574707065;5842.386549412293;5849.590528662995;5849.883002339972;5854.20968169296;5519.503244707996;5534.667919924777;5536.806211782608;5600.831975040755;5603.347012631283;6308.968455157695;6319.778807741707;6379.87240255197;6381.234251889757;6397.776077837299;4726.291056341542;4738.95261047392;4771.28430735389;4776;4832.130216561018;6333.123494908894;6522.402011507211;6633.800985970477;6658.167729033871;6721.151683287087;4815.15734746418;4846.39420072491;4864.927026094611;4881.389826271716;4943.752812359367;4960.826371076995;4966.925496117561;5000.5747212601855;5006.199008158677;5033.723145226974;5478.726063696879;5533.418991005967;5549.916751248735;5597.440255974451;5599.8600034998635;6344.143540622049;6347.301796802348;6455.419012288822;6484.513661475408;6499.512536559777;1717.1328479118215;1721.1927476150242;1740.390863197896;1745.6072383713563;1747.5281673948218;1154.2439701995206;1203.711109333771;1217.598192596441;1217.7686239614445;1233.5682511121036;5572.665640061528;5603.271574695264;5625.943740562624;5644.266245388073;5645.68948707825;6378.77674281398;6437.517186211053;6438.420542151229;6453.290138084807;6479.643619600967;5509.641873278224;5564.527015203753;5593.496585307342;5595.720213989284;5628.774849006076;3438.621751607321;3475.530803341567;3475.913102172466;3478.617352091268;3516.384632689269;6303.3066362700065;6308.116863639094;6317.368263173646;6349.174607301022;6362.936370636327;6481.28705842357;6657.53397262187;6674.432673222734;6704.3295670433545;6746.865062698718;6318.684065796784;6318.988961766096;6327.10186943915;6333.145025421693;6360.9045864312075;6519.674016299261;6548.869022619616;6553.311902250386;6590.637514936724;6596.538242322991;6292.339304373158;6435.774747883802;6474.2554606219;6517.4460170886005;6529.771457998947;5720.456556627114;6262.23874035879;6291.779787707408;6313.621182729051;6378.649174295459;4884.169691152441;4916.992016636509;4924.630652701134;4947.381577302837;4953.820319059602;6302;6388.488920886225;6494.870102598016;6538.411542961157;6566.540342176002;6332.52506062038;6384.968075159594;6394.968025159845;6409.519286053472;6428.325025872403;6377.904331435125;6380.744770209325;6393.264774550986;6405.263394709668;6436.420722135031;6260.812175634738;6325.620462772248;6350.253680237972;6353.570446649467;6366.681665916778;6319.146915166578;6359.268684101387;6386.297507274289;6415.1981002374705;6415.807525774234;6170.457385653586;6208.130861679459;6220.595661282002;6225.221847269091;6257.2804127525915 16:57:49 INFO - PID 30579 | |5;yui.html;908.8500397434424;920.8526635738281;929.9070092990697;933.323340578081;941.2658126661205;17563.12184390782;18314.35899743509;18379.26482940681;18455.538611534703;18496.537586560342;17523.824761752378;17839.821601783977;19052.142653580588;21976.8901155494;22131.225407110753;1004.2116938203511;1038.7818558102808;1039.8596189514433;1040.053551268346;1041.5209003858197;976.843705007199;1027.5889644142364;1037.6316407675279;1037.9532921018535;1069.043206330334;1110.2672236324029;1123.2474242257706;1124.662601219635;1125.482278152047;1128.3399211461306;1119.882412346704;1120.4509790202824;1123.6572845282185;1125.4485302201863;1126.2566705974018;824.5094168969454;826.2811354121892;827.5034979012604;828.8300898315831;828.8383765165795;19584.118714657874;19633.803661963484;19687.114079866442;20138.69791953122;21325.680114798135;21036.474088147766;21120;21537.784622153733;21599.460013499633;22054.448638783997;16235.269412876449;16317.836821631869;16434;16576.336946522126;16597.917010414993;3599.6040435552068;3604.0629436346476;3604.7296452766145;3605.242898991215;3605.963940360589;125489.37255313757;127082.72917270802;131573;132429;136189.31905340508;17072;17670.293188272582;17762.46712598624;17860.374886878897;17924.462266132035;31452.213694657818;31526.211844704067;31687;31774.523382149287;32426.513602295985;8832.98420681617;8849.734507964771;8882.777930551658;8901.376903616685;8943.955280223558;4156.916861662749;4243.151369726067;4296.076343586082;4306.310990241546;4308.3968244445805;4860.95139048605;4862;4992.700437973734;4992.90014199714;5046.39443266803;981.8625392445064;997.3417544420793;1007.8286691262502;1011.2870426349406;1048.8846226915034;647.1037612906159;666.9466442684574;677.6002158726375;679.1374953808734;682.7098483144644;10807.621733239299;11173;11791.29252244868;11846;12581.685457863443;658.9571677840925;700.5341447937167;712.9928700712926;714.5712572456589;726.9967444925968;5025.3718285214345;5241.868953276123;5284.916592098611;5315.468453154731;5500.779968801283;106413.46793265984;109335;110014.44992774985;110545;112434.43782781197;75486.02794411068;96660;97568.51215743876;98957;99681.50159249302;83997.58001209956;85193.57403213068;85689.57155214185;87920;90577.54711226402;11676.88323116792;11966.22219555726;12648;12716.300603466898;12794.936025319814;38873.80563097166;40157;40298.79850600728;40960;42791.3581296287;73266.63366683133;73716.26283737094;73910.63044684743;74191.25808741844;75501.62249188719;18122.27510899549;18204;18275.26898924028;18417;18618.53453663615;17629.73555396696;17840.91079544594;17841.73237401414;17906.5523361917;17936.551586210448;16970.151492425084;17002.914985424995;17113.572160696083;17227;17274;19149.234030638618;19575.412737617895;19612.9019354908;19742.21031158795;19788;17991.280348785902;18313.450596482126;18327.725084124017;18426.72359914629;18472.81527184711;12564.685882853002;12723.745525089631;12911.160774549624;13123.54067607629;13320.467181312639;12903.161294515827;12977.286249256003;13002.544910928073;13039.217646941213;13131.803022954473 16:57:49 INFO - PID 30579 | __end_tp_report 16:57:49 INFO - PID 30579 | __start_cc_report 16:57:49 INFO - PID 30579 | _x_x_mozilla_cycle_collect,387 16:57:49 INFO - PID 30579 | __end_cc_report 16:57:49 INFO - PID 30579 | __startTimestamp1503014269698__endTimestamp 16:57:49 INFO - PID 30579 | 16:57:49 INFO - PID 30579 | ------- Summary: start ------- 16:57:49 INFO - PID 30579 | Number of tests: 6 16:57:49 INFO - PID 30579 | 16:57:49 INFO - PID 30579 | [#0] dojo.html Cycles:165 Average:6120.71 Median:6393.81 stddev:706.16 (11.0%) stddev-sans-first:669.07 16:57:49 INFO - PID 30579 | Values: 3161.2 3188.7 3190.3 3202.8 3216.7 6180.0 6207.5 6248.8 6249.1 6274.0 6039.7 6044.6 6071.8 6121.2 6200.3 5660.5 5661.4 5681.1 5704.5 5728.0 5664.5 5685.8 5704.6 5728.7 5745.8 5685.7 5740.8 5742.9 5764.3 5765.7 5544.3 5721.7 5791.2 5793.8 5819.5 5582.2 5584.1 5593.6 5649.2 5677.0 6029.8 6084.7 6206.8 6225.3 6231.1 6509.2 6625.4 6627.6 6647.9 6708.4 6630.8 6678.0 6684.2 6687.6 6689.7 6179.0 6179.6 6248.4 6255.7 6259.4 6838.7 6911.8 6931.9 6956.1 6958.2 6449.5 6524.8 6572.9 6635.9 6661.6 6460.3 6532.6 6533.1 6555.2 6564.4 6499.8 6554.7 6561.9 6572.6 6574.3 6572.2 6574.5 6591.7 6604.2 6604.7 5402.6 5417.1 5420.4 5423.6 5449.5 4667.9 4681.8 4692.3 4693.7 4710.3 5649.1 5701.0 5716.0 5735.1 5738.7 6588.1 6678.1 6690.2 6722.0 6761.8 5691.1 5729.5 5765.2 5809.6 5821.2 5767.7 5850.7 5852.3 5853.6 5953.3 6393.8 6404.5 6414.3 6418.7 6419.5 6581.3 6613.7 6685.1 6728.6 6802.4 6483.5 6488.3 6510.9 6580.6 6618.8 6370.4 6434.4 6551.5 6648.4 6653.9 6649.8 6651.2 6664.8 6669.2 6697.8 6343.6 6421.7 6426.3 6434.5 6438.0 6405.0 6408.5 6418.9 6420.8 6427.4 6381.6 6389.4 6436.1 6459.2 6463.7 6543.3 6565.8 6583.2 6583.8 6589.5 6303.2 6322.6 6331.1 6412.6 6434.2 16:57:49 INFO - PID 30579 | 16:57:49 INFO - PID 30579 | [#1] ext.html Cycles:180 Average:37727.01 Median:34746.98 stddev:53510.53 (154.0%) stddev-sans-first:53588.65 16:57:49 INFO - PID 30579 | Values: 759.3 843.6 873.9 874.1 1163.6 30362.8 42117.8 43269.0 43313.4 43448.1 42565.4 42950.6 42969.0 43000.4 43043.4 5738.1 5870.8 7609.0 7741.9 7765.4 7569.7 7718.7 7735.2 7743.4 7746.9 7698.5 7724.3 7741.1 7742.3 7749.2 7673.1 7717.2 7733.0 7733.8 7736.4 7530.4 7570.5 7573.3 7579.1 7609.8 38485.0 38754.2 38807.0 38847.0 38880.4 3615.4 3652.1 3658.0 3660.4 3660.5 30596.7 30639.7 30687.4 30734.0 30775.8 4834.2 4845.4 4846.4 4867.6 4873.8 190030.0 190185.0 190306.0 190469.0 190629.0 47948.5 48222.8 48362.3 48426.5 48430.5 50788.7 50823.0 50855.0 50918.9 50964.7 13715.7 14012.6 14025.9 14033.8 14070.7 11056.3 11162.4 11344.9 11345.0 11357.3 12077.3 13567.1 14212.8 14219.9 14241.8 5339.6 5443.4 5507.8 5508.1 5579.4 1004.4 1007.5 1016.7 1026.2 1027.6 23113.7 23678.6 28562.4 29004.7 29839.3 1071.5 1075.2 1082.0 1084.3 1094.6 12671.7 12915.9 12954.6 12968.1 13026.9 230642.0 230887.0 231907.0 232190.0 232208.0 53508.7 53526.2 53657.0 53795.5 53848.5 1400.3 1444.2 1452.6 1467.6 1470.5 22678.0 22932.8 23045.1 23177.7 23362.4 38383.8 38429.6 38463.2 38509.6 38526.2 191698.0 193884.0 195463.0 196367.0 196557.0 34555.3 34724.5 34769.5 34877.5 35027.6 40918.6 42448.2 47301.8 48313.0 49098.3 34188.1 34536.5 34793.1 34886.0 35324.6 33899.7 34280.0 34345.7 34468.7 34608.1 31395.4 31495.5 31496.1 31589.4 31603.0 33101.5 33205.2 33478.5 33609.8 33854.5 24295.9 24683.9 25449.7 25554.6 25767.6 16:57:49 INFO - PID 30579 | 16:57:49 INFO - PID 30579 | [#2] jquery.html Cycles:180 Average:36781.76 Median:23581.97 stddev:90284.46 (382.9%) stddev-sans-first:90496.79 16:57:49 INFO - PID 30579 | Values: 568.5 571.4 572.3 575.8 597.2 21979.2 22747.0 22976.9 23032.9 23080.9 26150.7 26493.6 26497.5 26645.7 26657.3 6510.5 6637.9 6647.5 6654.1 6677.3 6135.4 6479.4 6480.4 6494.0 6533.6 6442.0 6448.4 6448.8 6456.2 6457.6 6457.3 6460.7 6464.2 6473.9 6477.2 6015.2 6020.8 6029.4 6036.0 6037.0 29011.6 30035.5 30115.7 30221.7 30614.1 1876.9 1888.7 1901.6 1907.7 1909.6 19388.1 20105.1 20115.8 20126.9 20129.7 2321.3 2335.6 2370.1 2373.8 2465.4 139470.0 147142.0 147498.0 147532.0 147565.3 14752.9 14876.9 15044.6 15464.7 15902.3 22843.7 23289.5 23477.8 23538.8 24045.0 9479.1 9595.9 9723.4 9733.9 9740.5 8656.6 8658.5 8659.6 8692.6 8741.6 9584.5 9786.8 9871.5 9871.7 9894.8 2727.3 2763.4 2797.3 2809.3 2821.8 963.2 981.6 982.6 988.7 994.4 19733.4 19902.5 20083.4 20481.0 20757.7 1035.3 1035.6 1047.1 1047.6 1051.4 10973.1 11184.8 11187.1 11217.3 11418.5 516056.0 529863.0 543645.0 544879.0 548254.0 119225.0 124149.0 124387.0 125080.0 126247.0 1164.4 1194.3 1215.4 1216.5 1219.0 17745.6 17797.4 17842.4 18020.4 18146.4 57095.4 57908.4 59401.0 61774.0 63240.7 72020.0 72558.3 72777.3 72816.0 73220.6 14776.9 15204.6 15314.0 15347.4 15363.3 23625.2 23757.2 23869.8 23897.5 24082.4 17666.6 17767.4 17817.4 18860.9 19062.1 16821.7 17114.7 17639.1 17641.9 18396.8 19115.0 19177.4 19378.3 19421.1 19442.2 14780.4 14867.7 14914.1 14919.4 14953.7 18085.3 18164.5 18215.9 18223.6 18417.0 16:57:49 INFO - PID 30579 | 16:57:49 INFO - PID 30579 | [#3] mootools.html Cycles:180 Average:8730.27 Median:2497.17 stddev:5953.34 (238.4%) stddev-sans-first:5944.63 16:57:49 INFO - PID 30579 | Values: 1410.2 1463.7 1465.7 1478.9 1489.9 13767.4 14325.1 14381.3 14403.8 14412.7 13996.9 14133.4 14139.7 14140.2 14152.6 2647.1 2676.9 2682.9 2685.1 2689.7 2537.7 2616.0 2620.8 2636.8 2642.9 2519.8 2526.1 2540.7 2560.4 2560.8 2488.1 2506.2 2511.0 2519.0 2522.4 2410.5 2435.2 2439.9 2442.5 2455.3 13751.8 14381.6 14421.6 14428.3 14434.8 7580.5 7885.0 7888.6 7888.8 7895.8 4858.3 5062.7 5154.7 5199.5 5203.5 1782.0 1799.8 1828.7 1845.6 1850.4 22788.3 22945.7 22966.3 22971.3 22997.2 6459.6 6574.2 6587.1 6738.5 6748.6 15875.8 15883.9 15890.6 15902.5 15927.4 7343.8 7481.1 7485.3 7510.1 7512.0 6867.6 6870.4 6885.8 6976.9 6983.5 4991.4 5105.4 5141.8 5158.5 5172.5 1478.1 1480.3 1482.1 1498.6 1501.5 915.8 925.5 934.3 944.0 944.9 7309.2 7431.5 7488.9 7585.1 7686.9 694.7 727.4 731.0 743.9 754.8 4781.3 5058.0 5070.6 5114.2 5364.6 18627.0 18698.6 19335.5 19446.8 19481.4 18911.1 18963.9 19015.2 19263.5 19263.7 10534.5 10540.0 10910.2 11037.1 11049.8 8188.9 8466.4 8638.4 8743.7 8775.0 16797.3 17236.4 17263.7 17383.0 17463.5 17197.0 17273.0 17316.5 17392.4 17481.0 11381.3 11561.8 11562.8 11633.4 11646.2 12877.2 12917.6 12987.5 13019.2 13061.5 10601.3 10689.9 10747.6 10856.2 10934.5 10626.3 10669.2 10693.5 10870.8 11045.7 9250.0 9256.8 9328.3 9364.7 9378.2 7036.0 7059.8 7119.7 7128.2 7138.1 7274.6 7327.3 7334.6 7402.1 7404.7 16:57:49 INFO - PID 30579 | 16:57:49 INFO - PID 30579 | [#4] prototype.html Cycles:180 Average:5362.39 Median:5888.46 stddev:1488.74 (25.3%) stddev-sans-first:1447.33 16:57:49 INFO - PID 30579 | Values: 491.9 519.9 525.7 530.2 532.3 5975.4 6008.5 6020.7 6038.8 6068.5 5922.7 5999.2 5999.3 6000.4 6014.8 5022.3 5031.4 5055.2 5067.1 5068.3 4662.5 4821.3 4927.6 4945.5 4997.0 4768.3 4820.7 4821.6 4844.5 4851.8 4795.4 4829.4 4834.0 4859.2 4874.2 4219.8 4343.4 4348.3 4371.0 4386.5 5772.6 5842.4 5849.6 5849.9 5854.2 5519.5 5534.7 5536.8 5600.8 5603.3 6309.0 6319.8 6379.9 6381.2 6397.8 4726.3 4739.0 4771.3 4776.0 4832.1 6333.1 6522.4 6633.8 6658.2 6721.2 4815.2 4846.4 4864.9 4881.4 4943.8 4960.8 4966.9 5000.6 5006.2 5033.7 5478.7 5533.4 5549.9 5597.4 5599.9 6344.1 6347.3 6455.4 6484.5 6499.5 1717.1 1721.2 1740.4 1745.6 1747.5 1154.2 1203.7 1217.6 1217.8 1233.6 5572.7 5603.3 5625.9 5644.3 5645.7 6378.8 6437.5 6438.4 6453.3 6479.6 5509.6 5564.5 5593.5 5595.7 5628.8 3438.6 3475.5 3475.9 3478.6 3516.4 6303.3 6308.1 6317.4 6349.2 6362.9 6481.3 6657.5 6674.4 6704.3 6746.9 6318.7 6319.0 6327.1 6333.1 6360.9 6519.7 6548.9 6553.3 6590.6 6596.5 6292.3 6435.8 6474.3 6517.4 6529.8 5720.5 6262.2 6291.8 6313.6 6378.6 4884.2 4917.0 4924.6 4947.4 4953.8 6302.0 6388.5 6494.9 6538.4 6566.5 6332.5 6385.0 6395.0 6409.5 6428.3 6377.9 6380.7 6393.3 6405.3 6436.4 6260.8 6325.6 6350.3 6353.6 6366.7 6319.1 6359.3 6386.3 6415.2 6415.8 6170.5 6208.1 6220.6 6225.2 6257.3 16:57:49 INFO - PID 30579 | 16:57:49 INFO - PID 30579 | [#5] yui.html Cycles:180 Average:23812.46 Median:19362.32 stddev:32518.93 (167.9%) stddev-sans-first:32564.68 16:57:49 INFO - PID 30579 | Values: 908.9 920.9 929.9 933.3 941.3 17563.1 18314.4 18379.3 18455.5 18496.5 17523.8 17839.8 19052.1 21976.9 22131.2 1004.2 1038.8 1039.9 1040.1 1041.5 976.8 1027.6 1037.6 1038.0 1069.0 1110.3 1123.2 1124.7 1125.5 1128.3 1119.9 1120.5 1123.7 1125.4 1126.3 824.5 826.3 827.5 828.8 828.8 19584.1 19633.8 19687.1 20138.7 21325.7 21036.5 21120.0 21537.8 21599.5 22054.4 16235.3 16317.8 16434.0 16576.3 16597.9 3599.6 3604.1 3604.7 3605.2 3606.0 125489.4 127082.7 131573.0 132429.0 136189.3 17072.0 17670.3 17762.5 17860.4 17924.5 31452.2 31526.2 31687.0 31774.5 32426.5 8833.0 8849.7 8882.8 8901.4 8944.0 4156.9 4243.2 4296.1 4306.3 4308.4 4861.0 4862.0 4992.7 4992.9 5046.4 981.9 997.3 1007.8 1011.3 1048.9 647.1 666.9 677.6 679.1 682.7 10807.6 11173.0 11791.3 11846.0 12581.7 659.0 700.5 713.0 714.6 727.0 5025.4 5241.9 5284.9 5315.5 5500.8 106413.5 109335.0 110014.4 110545.0 112434.4 75486.0 96660.0 97568.5 98957.0 99681.5 83997.6 85193.6 85689.6 87920.0 90577.5 11676.9 11966.2 12648.0 12716.3 12794.9 38873.8 40157.0 40298.8 40960.0 42791.4 73266.6 73716.3 73910.6 74191.3 75501.6 18122.3 18204.0 18275.3 18417.0 18618.5 17629.7 17840.9 17841.7 17906.6 17936.6 16970.2 17002.9 17113.6 17227.0 17274.0 19149.2 19575.4 19612.9 19742.2 19788.0 17991.3 18313.5 18327.7 18426.7 18472.8 12564.7 12723.7 12911.2 13123.5 13320.5 12903.2 12977.3 13002.5 13039.2 13131.8 16:57:49 INFO - PID 30579 | -------- Summary: end -------- 16:57:49 INFO - PID 30579 | 16:57:50 INFO - TEST-INFO | 30579: exit 0 16:57:50 INFO - TEST-OK | dromaeo_css | took 1112539ms 16:57:50 INFO - TEST-START | kraken 16:57:50 INFO - Initialising browser for kraken test... 16:57:50 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49201/getInfo.html -profile /tmp/tmpl2pucb/profile 16:57:50 INFO - TEST-INFO | started process 30955 (/builds/slave/test/build/application/firefox/firefox http://localhost:49201/getInfo.html) 16:57:56 INFO - TEST-INFO | 30955: exit 0 16:57:56 INFO - Browser initialized. 16:57:56 INFO - Running cycle 1/1 for kraken test... 16:57:56 INFO - TEST-INFO | started process 31149 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl2pucb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:57:57 INFO - PID 31149 | 16:57:57 INFO - PID 31149 | (/builds/slave/test/build/application/firefox/firefox:31204): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:57:57 INFO - PID 31149 | 16:58:07 INFO - PID 31149 | RSS: Main: 166100992 16:58:07 INFO - PID 31149 | 16:58:10 INFO - PID 31149 | Cycle 1(1): loaded http://localhost:49201/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49201/tests/kraken/driver.html?testName=audio-beat-detection) 16:58:11 INFO - PID 31149 | RSS: Main: 172879872 16:58:11 INFO - PID 31149 | 16:58:14 INFO - PID 31149 | Cycle 1(1): loaded http://localhost:49201/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49201/tests/kraken/driver.html?testName=audio-dft) 16:58:14 INFO - PID 31149 | RSS: Main: 173060096 16:58:14 INFO - PID 31149 | 16:58:17 INFO - PID 31149 | Cycle 1(1): loaded http://localhost:49201/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49201/tests/kraken/driver.html?testName=audio-fft) 16:58:18 INFO - PID 31149 | RSS: Main: 168026112 16:58:18 INFO - PID 31149 | 16:58:20 INFO - PID 31149 | Cycle 1(1): loaded http://localhost:49201/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49201/tests/kraken/driver.html?testName=audio-oscillator) 16:58:21 INFO - PID 31149 | RSS: Main: 168603648 16:58:21 INFO - PID 31149 | 16:58:23 INFO - PID 31149 | Cycle 1(1): loaded http://localhost:49201/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49201/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:58:24 INFO - PID 31149 | RSS: Main: 168488960 16:58:24 INFO - PID 31149 | 16:58:27 INFO - PID 31149 | Cycle 1(1): loaded http://localhost:49201/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49201/tests/kraken/driver.html?testName=imaging-darkroom) 16:58:27 INFO - PID 31149 | RSS: Main: 170840064 16:58:27 INFO - PID 31149 | 16:58:31 INFO - PID 31149 | Cycle 1(1): loaded http://localhost:49201/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49201/tests/kraken/driver.html?testName=imaging-desaturate) 16:58:32 INFO - PID 31149 | RSS: Main: 171008000 16:58:32 INFO - PID 31149 | 16:58:34 INFO - PID 31149 | Cycle 1(1): loaded http://localhost:49201/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49201/tests/kraken/driver.html?testName=json-parse-financial) 16:58:35 INFO - PID 31149 | RSS: Main: 171663360 16:58:35 INFO - PID 31149 | 16:58:37 INFO - PID 31149 | Cycle 1(1): loaded http://localhost:49201/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49201/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:58:37 INFO - PID 31149 | RSS: Main: 171438080 16:58:37 INFO - PID 31149 | 16:58:39 INFO - PID 31149 | Cycle 1(1): loaded http://localhost:49201/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49201/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:58:40 INFO - PID 31149 | RSS: Main: 171372544 16:58:40 INFO - PID 31149 | 16:58:42 INFO - PID 31149 | Cycle 1(1): loaded http://localhost:49201/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49201/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:58:43 INFO - PID 31149 | RSS: Main: 171601920 16:58:43 INFO - PID 31149 | 16:58:45 INFO - PID 31149 | Cycle 1(1): loaded http://localhost:49201/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49201/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:58:46 INFO - PID 31149 | RSS: Main: 172044288 16:58:46 INFO - PID 31149 | 16:58:49 INFO - PID 31149 | Cycle 1(1): loaded http://localhost:49201/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49201/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:58:50 INFO - PID 31149 | RSS: Main: 172036096 16:58:50 INFO - PID 31149 | 16:58:52 INFO - PID 31149 | Cycle 1(1): loaded http://localhost:49201/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49201/tests/kraken/driver.html?testName=ai-astar) 16:58:52 INFO - PID 31149 | RSS: Main: 173654016 16:58:52 INFO - PID 31149 | 16:58:52 INFO - PID 31149 | __start_tp_report 16:58:52 INFO - PID 31149 | _x_x_mozilla_page_load 16:58:52 INFO - PID 31149 | _x_x_mozilla_page_load_details 16:58:52 INFO - PID 31149 | |i|pagename|runs| 16:58:52 INFO - PID 31149 | |0;ai-astar;97;109;101;108;112;110;109;105;117;107 16:58:52 INFO - PID 31149 | |1;audio-beat-detection;152;117;147;181;119;143;148;118;174;119 16:58:52 INFO - PID 31149 | |2;audio-dft;164;164;163;170;167;164;168;169;168;167 16:58:52 INFO - PID 31149 | |3;audio-fft;75;74;76;174;79;75;74;85;165;84 16:58:52 INFO - PID 31149 | |4;audio-oscillator;78;81;139;78;79;84;127;79;79;126 16:58:52 INFO - PID 31149 | |5;imaging-gaussian-blur;118;114;114;119;118;115;114;115;115;114 16:58:52 INFO - PID 31149 | |6;imaging-darkroom;150;151;150;151;151;151;151;152;153;156 16:58:52 INFO - PID 31149 | |7;imaging-desaturate;95;99;94;98;94;100;95;96;93;94 16:58:52 INFO - PID 31149 | |8;json-parse-financial;54;54;58;54;55;55;55;54;55;55 16:58:52 INFO - PID 31149 | |9;json-stringify-tinderbox;54;54;54;62;54;54;53;54;54;55 16:58:52 INFO - PID 31149 | |10;stanford-crypto-aes;79;76;78;78;79;77;76;76;79;79 16:58:52 INFO - PID 31149 | |11;stanford-crypto-ccm;127;134;120;122;131;132;156;118;124;160 16:58:52 INFO - PID 31149 | |12;stanford-crypto-pbkdf2;175;176;171;175;174;176;175;181;175;175 16:58:52 INFO - PID 31149 | |13;stanford-crypto-sha256-iterative;69;67;67;70;69;72;70;69;67;66 16:58:52 INFO - PID 31149 | __end_tp_report 16:58:52 INFO - PID 31149 | __start_cc_report 16:58:52 INFO - PID 31149 | _x_x_mozilla_cycle_collect,994 16:58:52 INFO - PID 31149 | __end_cc_report 16:58:52 INFO - PID 31149 | __startTimestamp1503014332369__endTimestamp 16:58:52 INFO - PID 31149 | 16:58:52 INFO - PID 31149 | ------- Summary: start ------- 16:58:52 INFO - PID 31149 | Number of tests: 14 16:58:52 INFO - PID 31149 | 16:58:52 INFO - PID 31149 | [#0] ai-astar Cycles:10 Average:107.50 Median:109.50 stddev:5.58 (5.1%) stddev-sans-first:4.44 16:58:52 INFO - PID 31149 | Values: 97.0 109.0 101.0 108.0 112.0 110.0 109.0 105.0 117.0 107.0 16:58:52 INFO - PID 31149 | 16:58:52 INFO - PID 31149 | [#1] audio-beat-detection Cycles:10 Average:141.80 Median:147.50 stddev:23.49 (15.9%) stddev-sans-first:24.62 16:58:52 INFO - PID 31149 | Values: 152.0 117.0 147.0 181.0 119.0 143.0 148.0 118.0 174.0 119.0 16:58:52 INFO - PID 31149 | 16:58:52 INFO - PID 31149 | [#2] audio-dft Cycles:10 Average:166.40 Median:167.50 stddev:2.46 (1.5%) stddev-sans-first:2.45 16:58:52 INFO - PID 31149 | Values: 164.0 164.0 163.0 170.0 167.0 164.0 168.0 169.0 168.0 167.0 16:58:52 INFO - PID 31149 | 16:58:52 INFO - PID 31149 | [#3] audio-fft Cycles:10 Average:96.10 Median:75.50 stddev:38.94 (51.6%) stddev-sans-first:40.55 16:58:52 INFO - PID 31149 | Values: 75.0 74.0 76.0 174.0 79.0 75.0 74.0 85.0 165.0 84.0 16:58:52 INFO - PID 31149 | 16:58:52 INFO - PID 31149 | [#4] audio-oscillator Cycles:10 Average:95.00 Median:79.00 stddev:24.91 (31.5%) stddev-sans-first:25.65 16:58:52 INFO - PID 31149 | Values: 78.0 81.0 139.0 78.0 79.0 84.0 127.0 79.0 79.0 126.0 16:58:52 INFO - PID 31149 | 16:58:52 INFO - PID 31149 | [#5] imaging-gaussian-blur Cycles:10 Average:115.60 Median:115.00 stddev:1.96 (1.7%) stddev-sans-first:1.87 16:58:52 INFO - PID 31149 | Values: 118.0 114.0 114.0 119.0 118.0 115.0 114.0 115.0 115.0 114.0 16:58:52 INFO - PID 31149 | 16:58:52 INFO - PID 31149 | [#6] imaging-darkroom Cycles:10 Average:151.60 Median:151.00 stddev:1.78 (1.2%) stddev-sans-first:1.79 16:58:52 INFO - PID 31149 | Values: 150.0 151.0 150.0 151.0 151.0 151.0 151.0 152.0 153.0 156.0 16:58:52 INFO - PID 31149 | 16:58:52 INFO - PID 31149 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:95.00 stddev:2.39 (2.5%) stddev-sans-first:2.52 16:58:52 INFO - PID 31149 | Values: 95.0 99.0 94.0 98.0 94.0 100.0 95.0 96.0 93.0 94.0 16:58:52 INFO - PID 31149 | 16:58:52 INFO - PID 31149 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:1.20 (2.2%) stddev-sans-first:1.22 16:58:52 INFO - PID 31149 | Values: 54.0 54.0 58.0 54.0 55.0 55.0 55.0 54.0 55.0 55.0 16:58:52 INFO - PID 31149 | 16:58:52 INFO - PID 31149 | [#9] json-stringify-tinderbox Cycles:10 Average:54.80 Median:54.00 stddev:2.57 (4.8%) stddev-sans-first:2.71 16:58:52 INFO - PID 31149 | Values: 54.0 54.0 54.0 62.0 54.0 54.0 53.0 54.0 54.0 55.0 16:58:52 INFO - PID 31149 | 16:58:52 INFO - PID 31149 | [#10] stanford-crypto-aes Cycles:10 Average:77.70 Median:78.50 stddev:1.34 (1.7%) stddev-sans-first:1.33 16:58:52 INFO - PID 31149 | Values: 79.0 76.0 78.0 78.0 79.0 77.0 76.0 76.0 79.0 79.0 16:58:52 INFO - PID 31149 | 16:58:52 INFO - PID 31149 | [#11] stanford-crypto-ccm Cycles:10 Average:132.40 Median:131.50 stddev:14.50 (11.0%) stddev-sans-first:15.25 16:58:52 INFO - PID 31149 | Values: 127.0 134.0 120.0 122.0 131.0 132.0 156.0 118.0 124.0 160.0 16:58:52 INFO - PID 31149 | 16:58:52 INFO - PID 31149 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.30 Median:175.00 stddev:2.45 (1.4%) stddev-sans-first:2.60 16:58:52 INFO - PID 31149 | Values: 175.0 176.0 171.0 175.0 174.0 176.0 175.0 181.0 175.0 175.0 16:58:52 INFO - PID 31149 | 16:58:52 INFO - PID 31149 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:1.84 (2.7%) stddev-sans-first:1.94 16:58:52 INFO - PID 31149 | Values: 69.0 67.0 67.0 70.0 69.0 72.0 70.0 69.0 67.0 66.0 16:58:52 INFO - PID 31149 | -------- Summary: end -------- 16:58:52 INFO - PID 31149 | 16:58:52 INFO - PID 31149 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:58:53 INFO - TEST-INFO | 31149: exit 0 16:58:53 INFO - TEST-OK | kraken | took 62685ms 16:58:53 INFO - SUITE-END | took 1175s 16:58:53 INFO - Completed test suite (00:19:35) 16:58:53 INFO - javascript benchmark 16:58:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8436.28385521229, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3161.193895556633, 3188.697073777991, 3190.2981344104296, 3202.807831530107, 3216.6944140306664, 6179.969100154504, 6207.472364848988, 6248.84377890553, 6249.093881387196, 6273.996160614302, 6039.72821223045, 6044.576879618428, 6071.757129714806, 6121.173641558388, 6200.286966998797, 5660.5471562275025, 5661.405552416999, 5681.062624666945, 5704.54363650909, 5727.971360143193, 5664.518515926151, 5685.829425117233, 5704.572157088235, 5728.68492232927, 5745.770169193248, 5685.687287199203, 5740.827775166731, 5742.856428589277, 5764.308283006045, 5765.6540607563475, 5544.3346798384455, 5721.656700597978, 5791.247137872071, 5793.768249270045, 5819.505342045931, 5582.218489411485, 5584.078627026536, 5593.608447408683, 5649.209110724501, 5676.97814393409, 6029.758809647609, 6084.726187321537, 6206.844828879269, 6225.28409232935, 6231.127642130105, 6509.1863517060365, 6625.4037136657935, 6627.602343859384, 6647.933520664828, 6708.429783468411, 6630.801075967729, 6678.031685405637, 6684.231313398924, 6687.565308254996, 6689.665516724193, 6179.0422484514975, 6179.598326108789, 6248.4376406123665, 6255.718492667841, 6259.37406259375, 6838.692258848364, 6911.827204319932, 6931.930680693229, 6956.060931774247, 6958.234594194634, 6449.451796597248, 6524.804255872332, 6572.901406478906, 6635.900461493082, 6661.600303981777, 6460.3216662250725, 6532.5753826001155, 6533.052707357407, 6555.180602424697, 6564.442022428051, 6499.805005849832, 6554.7378104876225, 6561.868762624721, 6572.572782769104, 6574.342565743483, 6572.211334639874, 6574.474042076622, 6591.736330546724, 6604.240512341143, 6604.669766511655, 5402.594805389612, 5417.052015897202, 5420.430854760272, 5423.593230507728, 5449.536789372868, 4667.929981050287, 4681.789319480631, 4692.319613656069, 4693.671442998957, 4710.29345598163, 5649.096144616841, 5701.030824759718, 5715.971420142872, 5735.11105778605, 5738.655680659173, 6588.110605068255, 6678.09845670838, 6690.230623478362, 6721.966390168018, 6761.797146085625, 5691.146328050825, 5729.455701708331, 5765.1928729977835, 5809.593328467051, 5821.214136091573, 5767.740451679684, 5850.707464626752, 5852.326982397079, 5853.590248682552, 5953.3451320354725, 6393.808185754435, 6404.519661025442, 6414.294427612959, 6418.711157997808, 6419.45434638061, 6581.308962558863, 6613.66931653425, 6685.064091027163, 6728.596284222962, 6802.3537763912345, 6483.513736469878, 6488.253850807028, 6510.902336465051, 6580.605163690194, 6618.768343107968, 6370.362963703593, 6434.420902118832, 6551.541392102507, 6648.368405001517, 6653.933460665331, 6649.800505984828, 6651.16860392451, 6664.833379165366, 6669.166354205724, 6697.8325541859895, 6343.5876668016435, 6421.71102300407, 6426.29310775805, 6434.453071488976, 6437.967810160919, 6405.03924411342, 6408.487321014214, 6418.871622567429, 6420.839479013062, 6427.389398007182, 6381.617102973651, 6389.361063893573, 6436.066770318184, 6459.224893012869, 6463.709133089116, 6543.280239173592, 6565.835854103686, 6583.242927063257, 6583.769568065095, 6589.538732288694, 6303.212098487689, 6322.589031712924, 6331.05034244867, 6412.583182093149, 6434.163558737334], "value": 6069.17535239194, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [759.2673070486983, 843.5866425451528, 873.921347078763, 874.090945416767, 1163.6218229075541, 30362.848185759096, 42117.78941105294, 43269.0, 43313.35029974545, 43448.13103737924, 42565.36151957723, 42950.57049429505, 42969.0, 43000.35499467511, 43043.35434968478, 5738.139279108125, 5870.823875283727, 7609.048868891388, 7741.8838717419285, 7765.378769698411, 7569.697212111537, 7718.652660630285, 7735.226477352276, 7743.419243556727, 7746.9225307746765, 7698.461107722462, 7724.266194711493, 7741.071071471431, 7742.303192712655, 7749.186335434782, 7673.117591476996, 7717.151113377524, 7732.961335193288, 7733.8066548336465, 7736.381089512825, 7530.359919406857, 7570.545767253982, 7573.280538348903, 7579.052618422697, 7609.847803043908, 38485.037874053094, 38754.22491550153, 38807.029824254336, 38847.0, 38880.41679374812, 3615.403458429356, 3652.105234217607, 3657.963420365789, 3660.432632941898, 3660.524131862841, 30596.69403305983, 30639.69360306413, 30687.386252275053, 30734.0, 30775.846120769478, 4834.202356611155, 4845.370101886768, 4846.39420072491, 4867.586255168315, 4873.805047798084, 190029.9999999986, 190185.0, 190306.0, 190469.0, 190629.0, 47948.520514795106, 48222.758886205345, 48362.27456588154, 48426.515734842906, 48430.5156948426, 50788.74605626948, 50823.0, 50855.0, 50918.92648588104, 50964.74517627388, 13715.725685486233, 14012.649683757987, 14025.859741402659, 14033.78949315761, 14070.71858562823, 11056.281341712764, 11162.441877906234, 11344.886551134548, 11345.0, 11357.261777984404, 12077.335746534025, 13567.118137321042, 14212.786808197678, 14219.928900355431, 14241.78637320441, 5339.599530035185, 5443.401225865152, 5507.834764957058, 5508.091164957737, 5579.358373786985, 1004.437514991607, 1007.5163921317809, 1016.7254841192985, 1026.2098184397971, 1027.5735569738474, 23113.653295200584, 23678.64482032771, 28562.428751424854, 29004.68817161309, 29839.254018649706, 1071.5445935477392, 1075.1774892207468, 1081.9891801081887, 1084.311462221495, 1094.6497120921229, 12671.746565068832, 12915.935420322838, 12954.611361659165, 12968.09223354375, 13026.892714119405, 230642.0, 230887.0, 231907.0, 232190.0, 232208.0, 53508.73245633825, 53526.19710704342, 53657.0, 53795.46204537983, 53848.46151538513, 1400.26486094799, 1444.227338373986, 1452.5787521618613, 1467.6257554323793, 1470.4559313054237, 22678.0, 22932.77067229373, 23045.07819687194, 23177.652335215324, 23362.415939601648, 38383.80808095942, 38429.6157038426, 38463.230735385696, 38509.614903850605, 38526.229475410895, 191698.0, 193884.0, 195463.0, 196367.0, 196557.0, 34555.30889382248, 34724.47913281252, 34769.478457822646, 34877.47683784796, 35027.649723502436, 40918.590814091476, 42448.15103697847, 47301.763491182326, 48313.0, 49098.26352604642, 34188.14529636779, 34536.48195277123, 34793.086380249326, 34886.0, 35324.646753532135, 33899.66100338965, 34280.0, 34345.656543435245, 34468.65531344654, 34608.134796630286, 31395.372092557565, 31495.52756708697, 31496.055118346485, 31589.36821263608, 31603.0, 33101.503477447375, 33205.169870752456, 33478.497822533165, 33609.83195084009, 33854.492182616785, 24295.934845538326, 24683.876580616983, 25449.745502544738, 25554.6368336638, 25767.613485797352], "value": 17132.55030044365, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.4940403041293, 571.4143003421495, 572.3217986685778, 575.7524264566238, 597.2355385107063, 21979.23072692454, 22747.0, 22976.88511557442, 23032.884835575842, 23080.88459557702, 26150.73849261507, 26493.602595961074, 26497.470050598975, 26645.733542664566, 26657.333566660844, 6510.479161667079, 6637.93362066378, 6647.534672572921, 6654.101696271014, 6677.2988836172235, 6135.3557876423, 6479.384458476437, 6480.416762491375, 6494.0, 6533.60798352098, 6442.033694945772, 6448.387403196689, 6448.838779030515, 6456.225252969627, 6457.580257283285, 6457.2896981332015, 6460.709268082947, 6464.191976003, 6473.8705225895455, 6477.157969463963, 6015.248093988252, 6020.819375418744, 6029.427204415573, 6036.034234522455, 6036.9698151508965, 29011.564826527618, 30035.549466758017, 30115.69884301151, 30221.697783022108, 30614.081577552486, 1876.9249230030782, 1888.6694828404975, 1901.5816520365497, 1907.7043058325983, 1909.5703466720015, 19388.12753426099, 20105.095270712853, 20115.798842011685, 20126.899365503225, 20129.698054529195, 2321.3152120124605, 2335.5679199348006, 2370.0875163062174, 2373.8100951923975, 2465.408302007523, 139470.0, 147141.99999999892, 147498.0, 147532.0, 147565.26217368845, 14752.926235368968, 14876.925615371854, 15044.62388440276, 15464.690706185813, 15902.284397202153, 22843.657345139836, 23289.53420931572, 23477.765222347898, 23538.764612353658, 24045.0, 9479.146876781122, 9595.856062159073, 9723.367981081206, 9733.853992190123, 9740.512974351253, 8656.61045252965, 8658.48049117055, 8659.610317535726, 8692.608832602547, 8741.562921853882, 9584.520773961274, 9786.804263914682, 9871.50642467888, 9871.703848884545, 9894.80210395788, 2727.263638817548, 2763.350612606036, 2797.3146579087847, 2809.2555472799722, 2821.830690158597, 963.1764841060932, 981.5877331520778, 982.5529384130203, 988.7280997725683, 994.3636072913341, 19733.40799776009, 19902.50243743889, 20083.397498075083, 20481.0, 20757.688634670492, 1035.2856528994969, 1035.5650626736638, 1047.1256500821746, 1047.6333283350766, 1051.3849398102043, 10973.122150227962, 11184.776304474028, 11187.105031597453, 11217.326960382403, 11418.486168122454, 516056.0, 529863.0, 543645.0, 544879.0, 548254.0, 119225.0, 124149.0, 124387.0, 125080.0, 126247.0, 1164.441068287227, 1194.3431112887877, 1215.4348228073989, 1216.5498765456837, 1219.0430512048, 17745.556361091076, 17797.377091801725, 17842.375516856846, 18020.36928707489, 18146.364877229233, 57095.42904570901, 57908.4209157903, 59401.0, 61774.0, 63240.68379658072, 72020.0, 72558.27441725726, 72777.27222727705, 72816.0, 73220.63389683017, 14776.926115369355, 15204.637449403006, 15314.0, 15347.386104555693, 15363.308651110503, 23625.173118940755, 23757.218208634768, 23869.761302387447, 23897.522049558564, 24082.39794005164, 17666.5583360417, 17767.378141764977, 17817.376391826223, 18860.905695471436, 19062.142203600593, 16821.663566728843, 17114.657706845544, 17639.118044098, 17641.911790440965, 18396.81603183951, 19115.0, 19177.424677259703, 19378.321758738377, 19421.126049328097, 19442.222311107398, 14780.408783648963, 14867.702645947236, 14914.105153690813, 14919.403223870924, 14953.700925981202, 18085.276588936296, 18164.545886352946, 18215.908920455844, 18223.635527289644, 18417.0], "value": 12131.639182368504, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1410.1820943852567, 1463.7145756577465, 1465.6628975335673, 1478.94426746822, 1489.897475867858, 13767.380467878944, 14325.068870523435, 14381.280935953188, 14403.783943240847, 14412.711745765078, 13996.860031399683, 14133.434662613508, 14139.717205655881, 14140.222287774168, 14152.575422737335, 2647.073524266506, 2676.9063082792104, 2682.932926676829, 2685.073649590888, 2689.7444742749503, 2537.708163561186, 2615.973840261592, 2620.751028652275, 2636.841789492627, 2642.9339266518396, 2519.760622740837, 2526.090607381341, 2540.6697129373156, 2560.4111054457485, 2560.8335458195156, 2488.14159115105, 2506.1980166346775, 2511.033252197908, 2519.004993027762, 2522.432452698147, 2410.5178964207053, 2435.2207293666033, 2439.8536087834786, 2442.511497700449, 2455.2756936703713, 13751.793723094162, 14381.568552943429, 14421.567352979428, 14428.278586070759, 14434.783478247835, 7580.469367144302, 7885.0, 7888.605569721491, 7888.80277993049, 7895.763127106196, 4858.29554714568, 5062.747077550492, 5154.690718556899, 5199.4800519948085, 5203.505666961671, 1781.9554511137326, 1799.7660304160506, 1828.7256911463253, 1845.6308738252403, 1850.370873902866, 22788.31635050951, 22945.655815162787, 22966.311010669706, 22971.310860674206, 22997.19509817165, 6459.61242325462, 6574.211094668671, 6587.077809106729, 6738.494612903954, 6748.595084294958, 15875.761863572056, 15883.920580397024, 15890.60273493172, 15902.522924312289, 15927.362905483882, 7343.816404589821, 7481.064866891638, 7485.251474852471, 7510.061242344707, 7512.0, 6867.553609015398, 6870.416014638811, 6885.758998435031, 6976.895346569806, 6983.511154219156, 4991.401031876198, 5105.361829771278, 5141.76862041209, 5158.458361872024, 5172.5344718975475, 1478.0762023735165, 1480.267267702494, 1482.0959214878915, 1498.595379247619, 1501.5120085972103, 915.8031023330016, 925.4771054354268, 934.3086116273909, 944.0323668239971, 944.8677185194078, 7309.232530584212, 7431.479796414199, 7488.850222995509, 7585.089789225218, 7686.884696729554, 694.7047504810436, 727.3562896836232, 730.9926900730925, 743.9181690014094, 754.8414832885155, 4781.330613714083, 5058.038972595195, 5070.569001634903, 5114.207297868837, 5364.624476286623, 18627.0, 18698.626027479375, 19335.51661208481, 19446.80553194478, 19481.415557533295, 18911.14899829511, 18963.90518047401, 19015.239390424504, 19263.51841203953, 19263.711044334344, 10534.525946332433, 10540.0, 10910.23628346024, 11037.0618497427, 11049.779004420026, 8188.877166842383, 8466.449680770731, 8638.395312328328, 8743.650253989768, 8775.0, 16797.32810687559, 17236.396726114526, 17263.654726905643, 17383.0, 17463.47609571715, 17197.0, 17273.0, 17316.480505584852, 17392.391266305618, 17481.0, 11381.260218085798, 11561.768764624829, 11562.76874462523, 11633.360165190996, 11646.24299420535, 12877.227366358049, 12917.61247162549, 12987.545435909698, 13019.153755005895, 13061.477540898637, 10601.25791194609, 10689.94655026751, 10747.570097196338, 10856.2400631955, 10934.453277335942, 10626.309289896131, 10669.199810014436, 10693.51879165455, 10870.836937446104, 11045.668629941114, 9250.0, 9256.768580785534, 9328.253739700944, 9364.719058428258, 9378.155965963097, 7035.964820175866, 7059.752908648173, 7119.715211391486, 7128.215896251512, 7138.072050633385, 7274.563526188445, 7327.340539351484, 7334.559926404433, 7402.1117465904435, 7404.740834070997], "value": 6327.324859887553, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [491.8917838075622, 519.906416844968, 525.6609486880959, 530.2470491901499, 532.2681313194357, 5975.402459754023, 6008.519318454524, 6020.729067191976, 6038.8490287742825, 6068.514518838493, 5922.703864806764, 5999.160117583542, 5999.340072592022, 6000.4098913787775, 6014.789482368118, 5022.296878437012, 5031.396232452093, 5055.216441451581, 5067.113255180348, 5068.34111565496, 4662.51043640418, 4821.276808478721, 4927.605791536668, 4945.530174633422, 4997.0, 4768.308595253686, 4820.710757354553, 4821.566059054684, 4844.467108618049, 4851.830185943492, 4795.448523419816, 4829.372181616385, 4834.0, 4859.246816743375, 4874.244492103712, 4219.767912764797, 4343.391925130484, 4348.2607956647125, 4371.038371558252, 4386.451693538308, 5772.5670574707065, 5842.386549412293, 5849.590528662995, 5849.883002339972, 5854.20968169296, 5519.503244707996, 5534.667919924777, 5536.806211782608, 5600.831975040755, 5603.347012631283, 6308.968455157695, 6319.778807741707, 6379.87240255197, 6381.234251889757, 6397.776077837299, 4726.291056341542, 4738.95261047392, 4771.28430735389, 4776.0, 4832.130216561018, 6333.123494908894, 6522.402011507211, 6633.800985970477, 6658.167729033871, 6721.151683287087, 4815.15734746418, 4846.39420072491, 4864.927026094611, 4881.389826271716, 4943.752812359367, 4960.826371076995, 4966.925496117561, 5000.5747212601855, 5006.199008158677, 5033.723145226974, 5478.726063696879, 5533.418991005967, 5549.916751248735, 5597.440255974451, 5599.8600034998635, 6344.143540622049, 6347.301796802348, 6455.419012288822, 6484.513661475408, 6499.512536559777, 1717.1328479118215, 1721.1927476150242, 1740.390863197896, 1745.6072383713563, 1747.5281673948218, 1154.2439701995206, 1203.711109333771, 1217.598192596441, 1217.7686239614445, 1233.5682511121036, 5572.665640061528, 5603.271574695264, 5625.943740562624, 5644.266245388073, 5645.68948707825, 6378.77674281398, 6437.517186211053, 6438.420542151229, 6453.290138084807, 6479.643619600967, 5509.641873278224, 5564.527015203753, 5593.496585307342, 5595.720213989284, 5628.774849006076, 3438.621751607321, 3475.530803341567, 3475.913102172466, 3478.617352091268, 3516.384632689269, 6303.3066362700065, 6308.116863639094, 6317.368263173646, 6349.174607301022, 6362.936370636327, 6481.28705842357, 6657.53397262187, 6674.432673222734, 6704.3295670433545, 6746.865062698718, 6318.684065796784, 6318.988961766096, 6327.10186943915, 6333.145025421693, 6360.9045864312075, 6519.674016299261, 6548.869022619616, 6553.311902250386, 6590.637514936724, 6596.538242322991, 6292.339304373158, 6435.774747883802, 6474.2554606219, 6517.4460170886005, 6529.771457998947, 5720.456556627114, 6262.23874035879, 6291.779787707408, 6313.621182729051, 6378.649174295459, 4884.169691152441, 4916.992016636509, 4924.630652701134, 4947.381577302837, 4953.820319059602, 6302.0, 6388.488920886225, 6494.870102598016, 6538.411542961157, 6566.540342176002, 6332.52506062038, 6384.968075159594, 6394.968025159845, 6409.519286053472, 6428.325025872403, 6377.904331435125, 6380.744770209325, 6393.264774550986, 6405.263394709668, 6436.420722135031, 6260.812175634738, 6325.620462772248, 6350.253680237972, 6353.570446649467, 6366.681665916778, 6319.146915166578, 6359.268684101387, 6386.297507274289, 6415.1981002374705, 6415.807525774234, 6170.457385653586, 6208.130861679459, 6220.595661282002, 6225.221847269091, 6257.2804127525915], "value": 4930.0868365716715, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [908.8500397434424, 920.8526635738281, 929.9070092990697, 933.323340578081, 941.2658126661205, 17563.12184390782, 18314.35899743509, 18379.26482940681, 18455.538611534703, 18496.537586560342, 17523.824761752378, 17839.821601783977, 19052.142653580588, 21976.8901155494, 22131.225407110753, 1004.2116938203511, 1038.7818558102808, 1039.8596189514433, 1040.053551268346, 1041.5209003858197, 976.843705007199, 1027.5889644142364, 1037.6316407675279, 1037.9532921018535, 1069.043206330334, 1110.2672236324029, 1123.2474242257706, 1124.662601219635, 1125.482278152047, 1128.3399211461306, 1119.882412346704, 1120.4509790202824, 1123.6572845282185, 1125.4485302201863, 1126.2566705974018, 824.5094168969454, 826.2811354121892, 827.5034979012604, 828.8300898315831, 828.8383765165795, 19584.118714657874, 19633.803661963484, 19687.114079866442, 20138.69791953122, 21325.680114798135, 21036.474088147766, 21120.0, 21537.784622153733, 21599.460013499633, 22054.448638783997, 16235.269412876449, 16317.836821631869, 16434.0, 16576.336946522126, 16597.917010414993, 3599.6040435552068, 3604.0629436346476, 3604.7296452766145, 3605.242898991215, 3605.963940360589, 125489.37255313757, 127082.72917270802, 131573.0, 132429.0, 136189.31905340508, 17072.0, 17670.293188272582, 17762.46712598624, 17860.374886878897, 17924.462266132035, 31452.213694657818, 31526.211844704067, 31687.0, 31774.523382149287, 32426.513602295985, 8832.98420681617, 8849.734507964771, 8882.777930551658, 8901.376903616685, 8943.955280223558, 4156.916861662749, 4243.151369726067, 4296.076343586082, 4306.310990241546, 4308.3968244445805, 4860.95139048605, 4862.0, 4992.700437973734, 4992.90014199714, 5046.39443266803, 981.8625392445064, 997.3417544420793, 1007.8286691262502, 1011.2870426349406, 1048.8846226915034, 647.1037612906159, 666.9466442684574, 677.6002158726375, 679.1374953808734, 682.7098483144644, 10807.621733239299, 11173.0, 11791.29252244868, 11846.0, 12581.685457863443, 658.9571677840925, 700.5341447937167, 712.9928700712926, 714.5712572456589, 726.9967444925968, 5025.3718285214345, 5241.868953276123, 5284.916592098611, 5315.468453154731, 5500.779968801283, 106413.46793265984, 109335.0, 110014.44992774985, 110545.0, 112434.43782781197, 75486.02794411068, 96660.0, 97568.51215743876, 98957.0, 99681.50159249302, 83997.58001209956, 85193.57403213068, 85689.57155214185, 87920.0, 90577.54711226402, 11676.88323116792, 11966.22219555726, 12648.0, 12716.300603466898, 12794.936025319814, 38873.80563097166, 40157.0, 40298.79850600728, 40960.0, 42791.3581296287, 73266.63366683133, 73716.26283737094, 73910.63044684743, 74191.25808741844, 75501.62249188719, 18122.27510899549, 18204.0, 18275.26898924028, 18417.0, 18618.53453663615, 17629.73555396696, 17840.91079544594, 17841.73237401414, 17906.5523361917, 17936.551586210448, 16970.151492425084, 17002.914985424995, 17113.572160696083, 17227.0, 17274.0, 19149.234030638618, 19575.412737617895, 19612.9019354908, 19742.21031158795, 19788.0, 17991.280348785902, 18313.450596482126, 18327.725084124017, 18426.72359914629, 18472.81527184711, 12564.685882853002, 12723.745525089631, 12911.160774549624, 13123.54067607629, 13320.467181312639, 12903.161294515827, 12977.286249256003, 13002.544910928073, 13039.217646941213, 13131.803022954473], "value": 9160.796963634888, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1533.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 109.0, 101.0, 108.0, 112.0, 110.0, 109.0, 105.0, 117.0, 107.0], "value": 107.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 117.0, 147.0, 181.0, 119.0, 143.0, 148.0, 118.0, 174.0, 119.0], "value": 141.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 163.0, 170.0, 167.0, 164.0, 168.0, 169.0, 168.0, 167.0], "value": 166.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 174.0, 79.0, 75.0, 74.0, 85.0, 165.0, 84.0], "value": 96.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 81.0, 139.0, 78.0, 79.0, 84.0, 127.0, 79.0, 79.0, 126.0], "value": 95.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 114.0, 114.0, 119.0, 118.0, 115.0, 114.0, 115.0, 115.0, 114.0], "value": 115.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 150.0, 151.0, 151.0, 151.0, 151.0, 152.0, 153.0, 156.0], "value": 151.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 99.0, 94.0, 98.0, 94.0, 100.0, 95.0, 96.0, 93.0, 94.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 58.0, 54.0, 55.0, 55.0, 55.0, 54.0, 55.0, 55.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 62.0, 54.0, 54.0, 53.0, 54.0, 54.0, 55.0], "value": 54.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 76.0, 78.0, 78.0, 79.0, 77.0, 76.0, 76.0, 79.0, 79.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 134.0, 120.0, 122.0, 131.0, 132.0, 156.0, 118.0, 124.0, 160.0], "value": 132.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 176.0, 171.0, 175.0, 174.0, 176.0, 175.0, 181.0, 175.0, 175.0], "value": 175.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 67.0, 70.0, 69.0, 72.0, 70.0, 69.0, 67.0, 66.0], "value": 68.6, "unit": "score"}]}]} 16:58:53 INFO - Return code: 0 16:58:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:58:53 INFO - # TBPL SUCCESS # 16:58:53 INFO - Running post-action listener: _package_coverage_data 16:58:53 INFO - Running post-action listener: _resource_record_post_action 16:58:53 INFO - [mozharness: 2017-08-17 23:58:53.660746Z] Finished run-tests step (success) 16:58:53 INFO - Running post-run listener: _resource_record_post_run 16:58:53 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 436322304; Read time: 12; Write time: 271336 16:58:53 INFO - TinderboxPrint: CPU usage
13.1% 16:58:53 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 16:58:53 INFO - TinderboxPrint: I/O write bytes / time
436,322,304 / 271,336 16:58:53 INFO - TinderboxPrint: CPU idle
8,269.9 (86.9%) 16:58:53 INFO - TinderboxPrint: CPU user
1,200.7 (12.6%) 16:58:53 INFO - TinderboxPrint: Swap in / out
0 / 0 16:58:53 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 112521216; Read time: 0; Write time: 101812 16:58:53 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:58:53 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 323801088; Read time: 0; Write time: 169524 16:58:54 INFO - Running post-run listener: _upload_blobber_files 16:58:54 INFO - Blob upload gear active. 16:58:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:58:54 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 16:58:54 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'] 16:58:54 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 16:58:54 INFO - (blobuploader) - INFO - Open directory for files ... 16:58:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:58:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:58:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:58:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:58:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:58:55 INFO - (blobuploader) - INFO - Done attempting. 16:58:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:58:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:58:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:59:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:59:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:59:01 INFO - (blobuploader) - INFO - Done attempting. 16:59:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:59:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:59:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:59:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:59:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:59:02 INFO - (blobuploader) - INFO - Done attempting. 16:59:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:59:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:59:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:59:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:59:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:59:02 INFO - (blobuploader) - INFO - Done attempting. 16:59:02 INFO - (blobuploader) - INFO - Iteration through files over. 16:59:02 INFO - Return code: 0 16:59:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:59:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:59:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/da503016b0d1125ab7845062f2e1d5d6f8f1d3ce6eac97a4980b859f4a50d0a0528f769f6d7f5450dd4a7b096fcbf2dc7ae727f304fc7a04d89b6839a882d0e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f328368919b4cb486e92738d04d1f2d1927905e9b6230c12b90672fdaeb763934bfbedd07ed8ccca754fef36198aa1fb54f814669f38cb18a880295177d49138", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f94e8932bbb03add4ce0079d07badbd17b20f84d45510ec501436b327dacd62caa1ddafe7c5c71df9104e7c87a24eab869b123d97f077d4affe3ce7c4d72cca9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/265235d70e68c4aaf724c31dc88a0aeeded42c0f521bde24fa94e470cddc7932f74d8f29596827d81634d84ccd8e0dea8c7277d607bdf5c94f712c61626650cd"} 16:59:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:59:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:59:02 INFO - Contents: 16:59:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/da503016b0d1125ab7845062f2e1d5d6f8f1d3ce6eac97a4980b859f4a50d0a0528f769f6d7f5450dd4a7b096fcbf2dc7ae727f304fc7a04d89b6839a882d0e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f328368919b4cb486e92738d04d1f2d1927905e9b6230c12b90672fdaeb763934bfbedd07ed8ccca754fef36198aa1fb54f814669f38cb18a880295177d49138", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f94e8932bbb03add4ce0079d07badbd17b20f84d45510ec501436b327dacd62caa1ddafe7c5c71df9104e7c87a24eab869b123d97f077d4affe3ce7c4d72cca9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/265235d70e68c4aaf724c31dc88a0aeeded42c0f521bde24fa94e470cddc7932f74d8f29596827d81634d84ccd8e0dea8c7277d607bdf5c94f712c61626650cd"} 16:59:02 INFO - Running post-run listener: copy_logs_to_upload_dir 16:59:02 INFO - Copying logs to upload dir... 16:59:02 INFO - mkdir: /builds/slave/test/build/upload/logs 16:59:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.667767 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-08-17 16:59:03.017807) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-17 16:59:03.022562) ========= 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=41a7e32711b8e08598a63237000001d6-1503013085.451569-1706368872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/da503016b0d1125ab7845062f2e1d5d6f8f1d3ce6eac97a4980b859f4a50d0a0528f769f6d7f5450dd4a7b096fcbf2dc7ae727f304fc7a04d89b6839a882d0e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f328368919b4cb486e92738d04d1f2d1927905e9b6230c12b90672fdaeb763934bfbedd07ed8ccca754fef36198aa1fb54f814669f38cb18a880295177d49138", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f94e8932bbb03add4ce0079d07badbd17b20f84d45510ec501436b327dacd62caa1ddafe7c5c71df9104e7c87a24eab869b123d97f077d4affe3ce7c4d72cca9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/265235d70e68c4aaf724c31dc88a0aeeded42c0f521bde24fa94e470cddc7932f74d8f29596827d81634d84ccd8e0dea8c7277d607bdf5c94f712c61626650cd"} build_url:https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011576 build_url: 'https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/da503016b0d1125ab7845062f2e1d5d6f8f1d3ce6eac97a4980b859f4a50d0a0528f769f6d7f5450dd4a7b096fcbf2dc7ae727f304fc7a04d89b6839a882d0e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f328368919b4cb486e92738d04d1f2d1927905e9b6230c12b90672fdaeb763934bfbedd07ed8ccca754fef36198aa1fb54f814669f38cb18a880295177d49138", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f94e8932bbb03add4ce0079d07badbd17b20f84d45510ec501436b327dacd62caa1ddafe7c5c71df9104e7c87a24eab869b123d97f077d4affe3ce7c4d72cca9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/265235d70e68c4aaf724c31dc88a0aeeded42c0f521bde24fa94e470cddc7932f74d8f29596827d81634d84ccd8e0dea8c7277d607bdf5c94f712c61626650cd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-17 16:59:03.052443) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 16:59:03.052737) ========= 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=41a7e32711b8e08598a63237000001d6-1503013085.451569-1706368872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004532 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 16:59:03.134084) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-17 16:59:03.137398) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-17 16:59:03.137682) ========= ========= Total master_lag: 0.23 =========